builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0100 starttime: 1459898102.12 results: success (0) buildid: 20160405142117 builduid: f9c8f05d424d4b1da4a01694ee241cee revision: 6ebd54f5ed82ae5d85d45328939c783c27b5b77b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 16:15:02.118691) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 16:15:02.122180) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 16:15:02.122489) ========= 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.P11fffXo2d/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.zo640JgX4B/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005616 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 16:15:02.146834) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 16:15:02.147157) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 16:15:02.172567) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 16:15:02.172925) ========= 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.P11fffXo2d/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.zo640JgX4B/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005156 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 16:15:02.222053) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 16:15:02.222348) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 16:15:02.222700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 16:15:02.222990) ========= 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.P11fffXo2d/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.zo640JgX4B/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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:0:0 using PTY: False --2016-04-05 16:15:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2016-04-05 16:15:02 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130593 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 16:15:02.369076) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 16:15:02.369387) ========= 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.P11fffXo2d/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.zo640JgX4B/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.025600 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 16:15:02.417539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 16:15:02.417874) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6ebd54f5ed82ae5d85d45328939c783c27b5b77b --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 6ebd54f5ed82ae5d85d45328939c783c27b5b77b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.P11fffXo2d/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.zo640JgX4B/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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:0:0 using PTY: False 2016-04-05 16:15:02,497 truncating revision to first 12 chars 2016-04-05 16:15:02,497 Setting DEBUG logging. 2016-04-05 16:15:02,497 attempt 1/10 2016-04-05 16:15:02,497 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6ebd54f5ed82?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-05 16:15:03,188 unpacking tar archive at: mozilla-aurora-6ebd54f5ed82/testing/mozharness/ program finished with exit code 0 elapsedTime=0.943723 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 16:15:03.378395) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 16:15:03.378748) ========= echo 6ebd54f5ed82ae5d85d45328939c783c27b5b77b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6ebd54f5ed82ae5d85d45328939c783c27b5b77b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.P11fffXo2d/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.zo640JgX4B/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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:0:0 using PTY: False 6ebd54f5ed82ae5d85d45328939c783c27b5b77b program finished with exit code 0 elapsedTime=0.005486 script_repo_revision: '6ebd54f5ed82ae5d85d45328939c783c27b5b77b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 16:15:03.431388) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 16:15:03.431691) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 16:15:03.447224) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-05 16:15:03.447541) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --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', '--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.P11fffXo2d/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.zo640JgX4B/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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:0:0 using PTY: False 16:15:03 INFO - MultiFileLogger online at 20160405 16:15:03 in /builds/slave/test 16:15:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:15:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:15:03 INFO - {'append_to_log': False, 16:15:03 INFO - 'base_work_dir': '/builds/slave/test', 16:15:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:15:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:15:03 INFO - 'branch': 'Mozilla-Aurora', 16:15:03 INFO - 'buildbot_json_path': 'buildprops.json', 16:15:03 INFO - 'config_files': ('talos/mac_config.py',), 16:15:03 INFO - 'default_actions': ('clobber', 16:15:03 INFO - 'read-buildbot-config', 16:15:03 INFO - 'download-and-extract', 16:15:03 INFO - 'populate-webroot', 16:15:03 INFO - 'create-virtualenv', 16:15:03 INFO - 'install', 16:15:03 INFO - 'run-tests'), 16:15:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:15:03 INFO - 'download_minidump_stackwalk': True, 16:15:03 INFO - 'download_symbols': 'ondemand', 16:15:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:15:03 INFO - 'tooltool.py': '/tools/tooltool.py', 16:15:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:15:03 INFO - '/tools/misc-python/virtualenv.py')}, 16:15:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:15:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:15:03 INFO - 'installer_path': 'installer.exe', 16:15:03 INFO - 'log_level': 'info', 16:15:03 INFO - 'log_name': 'talos', 16:15:03 INFO - 'log_to_console': True, 16:15:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:15:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:15:03 INFO - 'opt_config_files': (), 16:15:03 INFO - 'pip_index': False, 16:15:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:15:03 INFO - 'cmd': ('bash', 16:15:03 INFO - '-c', 16:15:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:15:03 INFO - 'enabled': True, 16:15:03 INFO - 'halt_on_failure': False, 16:15:03 INFO - 'name': 'check_screen_resolution'},), 16:15:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:15:03 INFO - 'cmd': ('bash', 16:15:03 INFO - '-c', 16:15:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:15:03 INFO - 'enabled': True, 16:15:03 INFO - 'halt_on_failure': False, 16:15:03 INFO - 'name': 'check_screen_resolution'},), 16:15:03 INFO - 'run_cmd_checks_enabled': True, 16:15:03 INFO - 'sps_profile': False, 16:15:03 INFO - 'sps_profile_interval': 0, 16:15:03 INFO - 'suite': 'dromaeojs', 16:15:03 INFO - 'system_bits': '32', 16:15:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:15:03 INFO - 'title': 't-yosemite-r7-0100', 16:15:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:15:03 INFO - 'use_talos_json': True, 16:15:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:15:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:15:03 INFO - 'work_dir': 'build'} 16:15:03 INFO - ##### 16:15:03 INFO - ##### Running clobber step. 16:15:03 INFO - ##### 16:15:03 INFO - Running pre-action listener: _resource_record_pre_action 16:15:03 INFO - Running main action method: clobber 16:15:03 INFO - rmtree: /builds/slave/test/build 16:15:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:15:05 INFO - Running post-action listener: _resource_record_post_action 16:15:05 INFO - ##### 16:15:05 INFO - ##### Running read-buildbot-config step. 16:15:05 INFO - ##### 16:15:05 INFO - Running pre-action listener: _resource_record_pre_action 16:15:05 INFO - Running main action method: read_buildbot_config 16:15:05 INFO - Using buildbot properties: 16:15:05 INFO - { 16:15:05 INFO - "project": "", 16:15:05 INFO - "product": "firefox", 16:15:05 INFO - "script_repo_revision": "production", 16:15:05 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 16:15:05 INFO - "repository": "", 16:15:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 16:15:05 INFO - "buildid": "20160405142117", 16:15:05 INFO - "pgo_build": "False", 16:15:05 INFO - "basedir": "/builds/slave/test", 16:15:05 INFO - "buildnumber": 158, 16:15:05 INFO - "slavename": "t-yosemite-r7-0100", 16:15:05 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 16:15:05 INFO - "platform": "yosemite_r7", 16:15:05 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:15:05 INFO - "branch": "mozilla-aurora", 16:15:05 INFO - "repo_path": "releases/mozilla-aurora", 16:15:05 INFO - "revision": "6ebd54f5ed82ae5d85d45328939c783c27b5b77b", 16:15:05 INFO - "stage_platform": "macosx64", 16:15:05 INFO - "builduid": "f9c8f05d424d4b1da4a01694ee241cee", 16:15:05 INFO - "slavebuilddir": "test" 16:15:05 INFO - } 16:15:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 16:15:05 INFO - Running post-action listener: _resource_record_post_action 16:15:05 INFO - ##### 16:15:05 INFO - ##### Running download-and-extract step. 16:15:05 INFO - ##### 16:15:05 INFO - Running pre-action listener: _resource_record_pre_action 16:15:05 INFO - Running main action method: download_and_extract 16:15:05 INFO - mkdir: /builds/slave/test/build/tests 16:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:05 INFO - https://queue.taskcluster.net/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:15:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 16:15:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 16:15:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 16:15:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 16:15:06 INFO - Downloaded 1277 bytes. 16:15:06 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 16:15:06 INFO - Using the following test package requirements: 16:15:06 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 16:15:06 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:15:06 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 16:15:06 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:15:06 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 16:15:06 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:15:06 INFO - u'jsshell-mac.zip'], 16:15:06 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:15:06 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 16:15:06 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 16:15:06 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:15:06 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 16:15:06 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:15:06 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 16:15:06 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:15:06 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 16:15:06 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 16:15:06 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:15:06 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 16:15:06 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:15:06 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')]} 16:15:06 INFO - https://queue.taskcluster.net/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:15:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:15:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:15:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:15:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:15:11 INFO - Downloaded 17903436 bytes. 16:15:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:15:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:15:14 INFO - Return code: 0 16:15:14 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 16:15: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')]} 16:15:14 INFO - https://queue.taskcluster.net/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:15:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:15:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:15:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:15:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:15:16 INFO - Downloaded 17903436 bytes. 16:15:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:15:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:15:19 INFO - Return code: 0 16:15:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:19 INFO - https://queue.taskcluster.net/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:15:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 16:15:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 16:15:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 16:15:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:15:20 INFO - Downloaded 10845161 bytes. 16:15:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:15:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 16:15:21 INFO - Return code: 0 16:15: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')]} 16:15:21 INFO - https://queue.taskcluster.net/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 16:15:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 16:15:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 16:15:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 16:15:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 16:15:24 INFO - Downloaded 115183241 bytes. 16:15:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 16:15:24 INFO - mkdir: /builds/slave/test/properties 16:15:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:15:24 INFO - Writing to file /builds/slave/test/properties/build_url 16:15:24 INFO - Contents: 16:15:24 INFO - build_url:https://queue.taskcluster.net/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 16:15:25 INFO - Running post-action listener: _resource_record_post_action 16:15:25 INFO - Running post-action listener: set_extra_try_arguments 16:15:25 INFO - ##### 16:15:25 INFO - ##### Running populate-webroot step. 16:15:25 INFO - ##### 16:15:25 INFO - Running pre-action listener: _resource_record_pre_action 16:15:25 INFO - Running main action method: populate_webroot 16:15:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:15:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:15:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:15:25 INFO - '--tppagecycles', 16:15:25 INFO - '7'], 16:15:25 INFO - 'tests': ['tsvgm']}}, 16:15:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:15:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:15:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:15:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:15:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:15:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:15:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:15:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:25 INFO - 'talos_options': ['--e10s'], 16:15:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:15:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:25 INFO - 'tests': ['damp', 'tps']}, 16:15:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:25 INFO - 'talos_options': ['--e10s'], 16:15:25 INFO - 'tests': ['damp', 'tps']}, 16:15:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:15:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:15:25 INFO - 'other': {'tests': ['a11yr', 16:15:25 INFO - 'ts_paint', 16:15:25 INFO - 'tpaint', 16:15:25 INFO - 'sessionrestore', 16:15:25 INFO - 'sessionrestore_no_auto_restore', 16:15:25 INFO - 'tabpaint']}, 16:15:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:15:25 INFO - 'tests': ['a11yr', 16:15:25 INFO - 'ts_paint', 16:15:25 INFO - 'tpaint', 16:15:25 INFO - 'sessionrestore', 16:15:25 INFO - 'sessionrestore_no_auto_restore', 16:15:25 INFO - 'tabpaint']}, 16:15:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:15:25 INFO - 'tests': ['a11yr', 16:15:25 INFO - 'ts_paint', 16:15:25 INFO - 'tpaint', 16:15:25 INFO - 'sessionrestore', 16:15:25 INFO - 'sessionrestore_no_auto_restore', 16:15:25 INFO - 'tabpaint']}, 16:15:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:15:25 INFO - 'tests': ['a11yr', 16:15:25 INFO - 'ts_paint', 16:15:25 INFO - 'tpaint', 16:15:25 INFO - 'sessionrestore', 16:15:25 INFO - 'sessionrestore_no_auto_restore', 16:15:25 INFO - 'tabpaint']}, 16:15:25 INFO - 'other_l64': {'tests': ['a11yr', 16:15:25 INFO - 'ts_paint', 16:15:25 INFO - 'tpaint', 16:15:25 INFO - 'sessionrestore', 16:15:25 INFO - 'sessionrestore_no_auto_restore', 16:15:25 INFO - 'tabpaint']}, 16:15:25 INFO - 'other_nol64': {'tests': ['a11yr', 16:15:25 INFO - 'ts_paint', 16:15:25 INFO - 'tpaint', 16:15:25 INFO - 'sessionrestore', 16:15:25 INFO - 'sessionrestore_no_auto_restore', 16:15:25 INFO - 'tabpaint']}, 16:15:25 INFO - 'svgr': {'tests': ['tsvgx', 16:15:25 INFO - 'tsvgr_opacity', 16:15:25 INFO - 'tart', 16:15:25 INFO - 'tscrollx', 16:15:25 INFO - 'cart']}, 16:15:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:15:25 INFO - 'tests': ['tsvgx', 16:15:25 INFO - 'tsvgr_opacity', 16:15:25 INFO - 'tart', 16:15:25 INFO - 'tscrollx', 16:15:25 INFO - 'cart']}, 16:15:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:25 INFO - 'tests': ['tp5o']}, 16:15:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:25 INFO - 'talos_options': ['--e10s'], 16:15:25 INFO - 'tests': ['tp5o']}, 16:15:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:25 INFO - 'talos_options': ['--xperf_path', 16:15:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:15:25 INFO - 'tests': ['tp5n']}, 16:15:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:25 INFO - 'talos_options': ['--e10s', 16:15:25 INFO - '--xperf_path', 16:15:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:15:25 INFO - 'tests': ['tp5n']}}, 16:15:25 INFO - 'talos.zip': {'path': '', 16:15:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:15:25 INFO - Running post-action listener: _resource_record_post_action 16:15:25 INFO - ##### 16:15:25 INFO - ##### Running create-virtualenv step. 16:15:25 INFO - ##### 16:15:25 INFO - Running pre-action listener: _resource_record_pre_action 16:15:25 INFO - Running main action method: create_virtualenv 16:15:25 INFO - Creating virtualenv /builds/slave/test/build/venv 16:15:25 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 16:15:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:15:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:15:25 INFO - Using real prefix '/tools/python27' 16:15:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:15:26 INFO - Installing distribute.............................................................................................................................................................................................done. 16:15:29 INFO - Installing pip.................done. 16:15:29 INFO - Return code: 0 16:15:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x101df7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dfe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6905c5ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c9bd30>, '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 0x101affdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c92b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P11fffXo2d/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.zo640JgX4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:15:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 16:15:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 16:15:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P11fffXo2d/Render', 16:15:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:15:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:15:29 INFO - 'HOME': '/Users/cltbld', 16:15:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:15:29 INFO - 'LOGNAME': 'cltbld', 16:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:29 INFO - 'MOZ_NO_REMOTE': '1', 16:15:29 INFO - 'NO_EM_RESTART': '1', 16:15:29 INFO - 'PAGER': '/bin/cat', 16:15:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:29 INFO - 'PWD': '/builds/slave/test', 16:15:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:15:29 INFO - 'SHELL': '/bin/bash', 16:15:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zo640JgX4B/Listeners', 16:15:29 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 16:15:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:15:29 INFO - 'USER': 'cltbld', 16:15:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:15:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:29 INFO - 'XPC_FLAGS': '0x0', 16:15:29 INFO - 'XPC_SERVICE_NAME': '0', 16:15:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:29 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 16:15:29 INFO - Cleaning up... 16:15:29 INFO - Return code: 0 16:15:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x101df7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dfe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6905c5ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c9bd30>, '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 0x101affdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c92b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P11fffXo2d/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.zo640JgX4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:15:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 16:15:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 16:15:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P11fffXo2d/Render', 16:15:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:15:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:15:29 INFO - 'HOME': '/Users/cltbld', 16:15:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:15:29 INFO - 'LOGNAME': 'cltbld', 16:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:29 INFO - 'MOZ_NO_REMOTE': '1', 16:15:29 INFO - 'NO_EM_RESTART': '1', 16:15:29 INFO - 'PAGER': '/bin/cat', 16:15:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:29 INFO - 'PWD': '/builds/slave/test', 16:15:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:15:29 INFO - 'SHELL': '/bin/bash', 16:15:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zo640JgX4B/Listeners', 16:15:29 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 16:15:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:15:29 INFO - 'USER': 'cltbld', 16:15:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:15:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:29 INFO - 'XPC_FLAGS': '0x0', 16:15:29 INFO - 'XPC_SERVICE_NAME': '0', 16:15:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:29 INFO - Downloading/unpacking psutil>=0.7.1 16:15:29 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 16:15:29 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 16:15:29 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 16:15:29 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 16:15:29 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 16:15:29 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 16:15:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:15:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:15:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:15:32 INFO - Installing collected packages: psutil 16:15:32 INFO - Running setup.py install for psutil 16:15:32 INFO - building 'psutil._psutil_osx' extension 16:15: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:15: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/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:15: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 16:15: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 16:15:33 INFO - building 'psutil._psutil_posix' extension 16:15: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 16:15:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:15:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:15:33 INFO - ^ 16:15:33 INFO - 1 warning generated. 16:15: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 16:15:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:15:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:15:33 INFO - Successfully installed psutil 16:15:33 INFO - Cleaning up... 16:15:34 INFO - Return code: 0 16:15:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:15:34 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')]} 16:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:34 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')]} 16:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x101df7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dfe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6905c5ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c9bd30>, '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 0x101affdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c92b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P11fffXo2d/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.zo640JgX4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 16:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 16:15:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P11fffXo2d/Render', 16:15:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:15:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:15:34 INFO - 'HOME': '/Users/cltbld', 16:15:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:15:34 INFO - 'LOGNAME': 'cltbld', 16:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:34 INFO - 'MOZ_NO_REMOTE': '1', 16:15:34 INFO - 'NO_EM_RESTART': '1', 16:15:34 INFO - 'PAGER': '/bin/cat', 16:15:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:34 INFO - 'PWD': '/builds/slave/test', 16:15:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:15:34 INFO - 'SHELL': '/bin/bash', 16:15:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zo640JgX4B/Listeners', 16:15:34 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 16:15:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:15:34 INFO - 'USER': 'cltbld', 16:15:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:15:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:34 INFO - 'XPC_FLAGS': '0x0', 16:15:34 INFO - 'XPC_SERVICE_NAME': '0', 16:15:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:15: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 16:15: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 16:15: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 16:15: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 16:15: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 16:15: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 16:15:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:15:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:15: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) 16:15:36 INFO - Installing collected packages: mozsystemmonitor 16:15:36 INFO - Running setup.py install for mozsystemmonitor 16:15:36 INFO - Successfully installed mozsystemmonitor 16:15:36 INFO - Cleaning up... 16:15:37 INFO - Return code: 0 16:15:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x101df7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dfe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6905c5ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c9bd30>, '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 0x101affdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c92b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P11fffXo2d/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.zo640JgX4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:15:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 16:15:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 16:15:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P11fffXo2d/Render', 16:15:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:15:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:15:37 INFO - 'HOME': '/Users/cltbld', 16:15:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:15:37 INFO - 'LOGNAME': 'cltbld', 16:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:37 INFO - 'MOZ_NO_REMOTE': '1', 16:15:37 INFO - 'NO_EM_RESTART': '1', 16:15:37 INFO - 'PAGER': '/bin/cat', 16:15:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:37 INFO - 'PWD': '/builds/slave/test', 16:15:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:15:37 INFO - 'SHELL': '/bin/bash', 16:15:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zo640JgX4B/Listeners', 16:15:37 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 16:15:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:15:37 INFO - 'USER': 'cltbld', 16:15:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:15:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:37 INFO - 'XPC_FLAGS': '0x0', 16:15:37 INFO - 'XPC_SERVICE_NAME': '0', 16:15:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:37 INFO - Downloading/unpacking blobuploader==1.2.4 16:15: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 16:15: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 16:15: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 16:15: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 16:15: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 16:15: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 16:15:39 INFO - Downloading blobuploader-1.2.4.tar.gz 16:15:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:15:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:15: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 16:15: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 16:15: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 16:15: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 16:15: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 16:15: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 16:15:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:15:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:15: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 16:15: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 16:15: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 16:15: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 16:15: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 16:15: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 16:15:40 INFO - Downloading docopt-0.6.1.tar.gz 16:15:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:15:41 INFO - Installing collected packages: blobuploader, requests, docopt 16:15:41 INFO - Running setup.py install for blobuploader 16:15:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:15:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:15:41 INFO - Running setup.py install for requests 16:15:41 INFO - Running setup.py install for docopt 16:15:41 INFO - Successfully installed blobuploader requests docopt 16:15:41 INFO - Cleaning up... 16:15:41 INFO - Return code: 0 16:15:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:15: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')]} 16:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15: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')]} 16:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x101df7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dfe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6905c5ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c9bd30>, '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 0x101affdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c92b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P11fffXo2d/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.zo640JgX4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:15:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 16:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 16:15:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P11fffXo2d/Render', 16:15:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:15:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:15:41 INFO - 'HOME': '/Users/cltbld', 16:15:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:15:41 INFO - 'LOGNAME': 'cltbld', 16:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:41 INFO - 'MOZ_NO_REMOTE': '1', 16:15:41 INFO - 'NO_EM_RESTART': '1', 16:15:41 INFO - 'PAGER': '/bin/cat', 16:15:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:41 INFO - 'PWD': '/builds/slave/test', 16:15:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:15:41 INFO - 'SHELL': '/bin/bash', 16:15:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zo640JgX4B/Listeners', 16:15:41 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 16:15:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:15:41 INFO - 'USER': 'cltbld', 16:15:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:15:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:41 INFO - 'XPC_FLAGS': '0x0', 16:15:41 INFO - 'XPC_SERVICE_NAME': '0', 16:15:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:15:42 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-Cp7bwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:15:42 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-bcZYgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:15:42 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-zEgfPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:15:42 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-YtOnss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:15:42 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-Qx6hoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:15:42 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-K9nbBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:15:42 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-ttne0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:15:42 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-RyuHhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:15:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-o_XZfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:15:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-of_QYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:15:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-H3Riea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:15:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-4cpTgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:15:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-HOV2hP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:15:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-9ZZj4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-qPzG1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:15:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-cPayhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:15:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-jLDPWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:15:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:15:43 INFO - Running setup.py install for manifestparser 16:15:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:15:44 INFO - Running setup.py install for mozcrash 16:15:44 INFO - Running setup.py install for mozdebug 16:15:44 INFO - Running setup.py install for mozdevice 16:15:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:15:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:15:44 INFO - Running setup.py install for mozfile 16:15:44 INFO - Running setup.py install for mozhttpd 16:15:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:15:44 INFO - Running setup.py install for mozinfo 16:15:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:15:44 INFO - Running setup.py install for mozInstall 16:15:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Running setup.py install for mozleak 16:15:45 INFO - Running setup.py install for mozlog 16:15:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Running setup.py install for moznetwork 16:15:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Running setup.py install for mozprocess 16:15:45 INFO - Running setup.py install for mozprofile 16:15:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Running setup.py install for mozrunner 16:15:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:15:46 INFO - Running setup.py install for mozscreenshot 16:15:46 INFO - Running setup.py install for moztest 16:15:46 INFO - Running setup.py install for mozversion 16:15:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:15:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:15:46 INFO - Cleaning up... 16:15:46 INFO - Return code: 0 16:15:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:15:46 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')]} 16:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:46 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')]} 16:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x101df7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dfe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6905c5ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c9bd30>, '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 0x101affdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c92b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P11fffXo2d/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.zo640JgX4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:15:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 16:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 16:15:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P11fffXo2d/Render', 16:15:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:15:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:15:46 INFO - 'HOME': '/Users/cltbld', 16:15:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:15:46 INFO - 'LOGNAME': 'cltbld', 16:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:46 INFO - 'MOZ_NO_REMOTE': '1', 16:15:46 INFO - 'NO_EM_RESTART': '1', 16:15:46 INFO - 'PAGER': '/bin/cat', 16:15:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:46 INFO - 'PWD': '/builds/slave/test', 16:15:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:15:46 INFO - 'SHELL': '/bin/bash', 16:15:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zo640JgX4B/Listeners', 16:15:46 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 16:15:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:15:46 INFO - 'USER': 'cltbld', 16:15:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:15:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:46 INFO - 'XPC_FLAGS': '0x0', 16:15:46 INFO - 'XPC_SERVICE_NAME': '0', 16:15:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:15:46 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-bb7WNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:15:46 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)) 16:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:15:46 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-liofub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:15:47 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-svsrUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:15: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)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:15:47 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-9p_M_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:15:47 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-a2IZ3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:15:47 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)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:15:47 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-r4zuZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:15:47 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)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:15:47 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-A7QYfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:15:47 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-ZCAunq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:15:47 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)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:15:47 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-qtcg_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:15:47 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)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:15:47 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-RSzHyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:15:47 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-ZgQ1ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:15:47 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)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:15:47 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-YxxoKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:15: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)) 16:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:15:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-ZTaNU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 16:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:15:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-y7ayg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:15:48 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)) 16:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-csA0AD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:48 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)) 16:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:15:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-UWzaw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:15:48 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)) 16:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:15:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-ZWQbuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:15:48 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)) 16:15:48 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:15:48 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:15:48 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)) 16:15:48 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:15:48 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:15:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:15:48 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 16:15:48 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 16:15:48 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 16:15:48 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 16:15:48 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 16:15:48 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 16:15:51 INFO - Downloading blessings-1.6.tar.gz 16:15:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:15:51 INFO - Installing collected packages: blessings 16:15:51 INFO - Running setup.py install for blessings 16:15:51 INFO - Successfully installed blessings 16:15:51 INFO - Cleaning up... 16:15:51 INFO - Return code: 0 16:15:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:15:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:15:51 INFO - Reading from file tmpfile_stdout 16:15:51 INFO - Current package versions: 16:15:51 INFO - blessings == 1.6 16:15:51 INFO - blobuploader == 1.2.4 16:15:51 INFO - docopt == 0.6.1 16:15:51 INFO - manifestparser == 1.1 16:15:51 INFO - mozInstall == 1.12 16:15:51 INFO - mozcrash == 0.17 16:15:51 INFO - mozdebug == 0.1 16:15:51 INFO - mozdevice == 0.48 16:15:51 INFO - mozfile == 1.2 16:15:51 INFO - mozhttpd == 0.7 16:15:51 INFO - mozinfo == 0.9 16:15:51 INFO - mozleak == 0.1 16:15:51 INFO - mozlog == 3.1 16:15:51 INFO - moznetwork == 0.27 16:15:51 INFO - mozprocess == 0.22 16:15:51 INFO - mozprofile == 0.28 16:15:51 INFO - mozrunner == 6.11 16:15:51 INFO - mozscreenshot == 0.1 16:15:51 INFO - mozsystemmonitor == 0.0 16:15:51 INFO - moztest == 0.7 16:15:51 INFO - mozversion == 1.4 16:15:51 INFO - psutil == 3.1.1 16:15:51 INFO - requests == 1.2.3 16:15:51 INFO - wsgiref == 0.1.2 16:15:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x101df7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dfe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6905c5ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c9bd30>, '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 0x101affdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c92b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P11fffXo2d/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.zo640JgX4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:15:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 16:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 16:15:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P11fffXo2d/Render', 16:15:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:15:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:15:51 INFO - 'HOME': '/Users/cltbld', 16:15:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:15:51 INFO - 'LOGNAME': 'cltbld', 16:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:51 INFO - 'MOZ_NO_REMOTE': '1', 16:15:51 INFO - 'NO_EM_RESTART': '1', 16:15:51 INFO - 'PAGER': '/bin/cat', 16:15:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:51 INFO - 'PWD': '/builds/slave/test', 16:15:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:15:51 INFO - 'SHELL': '/bin/bash', 16:15:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zo640JgX4B/Listeners', 16:15:51 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 16:15:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:15:51 INFO - 'USER': 'cltbld', 16:15:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:15:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:51 INFO - 'XPC_FLAGS': '0x0', 16:15:51 INFO - 'XPC_SERVICE_NAME': '0', 16:15:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:15:52 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 2)) 16:15:52 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 3)) 16:15:52 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 4)) 16:15:52 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 5)) 16:15:52 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 6)) 16:15:52 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 7)) 16:15:52 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 8)) 16:15:52 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 9)) 16:15:52 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:15:52 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 4)) 16:15:52 INFO - Cleaning up... 16:15:52 INFO - Return code: 0 16:15:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:15: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')]} 16:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15: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')]} 16:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101df7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dfe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6905c5ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c9bd30>, '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 0x101affdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c92b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P11fffXo2d/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.zo640JgX4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:15:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema'] in /builds/slave/test/build 16:15:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 jsonschema 16:15:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P11fffXo2d/Render', 16:15:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:15:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:15:52 INFO - 'HOME': '/Users/cltbld', 16:15:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:15:52 INFO - 'LOGNAME': 'cltbld', 16:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:52 INFO - 'MOZ_NO_REMOTE': '1', 16:15:52 INFO - 'NO_EM_RESTART': '1', 16:15:52 INFO - 'PAGER': '/bin/cat', 16:15:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:52 INFO - 'PWD': '/builds/slave/test', 16:15:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:15:52 INFO - 'SHELL': '/bin/bash', 16:15:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zo640JgX4B/Listeners', 16:15:52 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 16:15:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:15:52 INFO - 'USER': 'cltbld', 16:15:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:15:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:52 INFO - 'XPC_FLAGS': '0x0', 16:15:52 INFO - 'XPC_SERVICE_NAME': '0', 16:15:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:52 INFO - Downloading/unpacking jsonschema 16:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:15:54 INFO - Downloading/unpacking functools32 (from jsonschema) 16:15:54 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 16:15:54 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 16:15:54 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 16:15:54 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 16:15:54 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 16:15:54 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 16:15:55 INFO - Downloading functools32-3.2.3-2.tar.gz 16:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:15:55 INFO - warning: no files found matching '*.txt' 16:15:55 INFO - no previously-included directories found matching 'build' 16:15:55 INFO - no previously-included directories found matching 'dist' 16:15:55 INFO - no previously-included directories found matching '.git*' 16:15:55 INFO - Installing collected packages: jsonschema, functools32 16:15:55 INFO - Running setup.py install for functools32 16:15:55 INFO - warning: no files found matching '*.txt' 16:15:55 INFO - no previously-included directories found matching 'build' 16:15:55 INFO - no previously-included directories found matching 'dist' 16:15:55 INFO - no previously-included directories found matching '.git*' 16:15:55 INFO - Successfully installed jsonschema functools32 16:15:55 INFO - Cleaning up... 16:15:55 INFO - Return code: 0 16:15:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101df7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dfe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6905c5ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c9bd30>, '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 0x101affdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c92b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P11fffXo2d/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.zo640JgX4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:15:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'flake8'] in /builds/slave/test/build 16:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 flake8 16:15:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P11fffXo2d/Render', 16:15:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:15:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:15:55 INFO - 'HOME': '/Users/cltbld', 16:15:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:15:55 INFO - 'LOGNAME': 'cltbld', 16:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:55 INFO - 'MOZ_NO_REMOTE': '1', 16:15:55 INFO - 'NO_EM_RESTART': '1', 16:15:55 INFO - 'PAGER': '/bin/cat', 16:15:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:55 INFO - 'PWD': '/builds/slave/test', 16:15:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:15:55 INFO - 'SHELL': '/bin/bash', 16:15:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zo640JgX4B/Listeners', 16:15:55 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 16:15:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:15:55 INFO - 'USER': 'cltbld', 16:15:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:15:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:55 INFO - 'XPC_FLAGS': '0x0', 16:15:55 INFO - 'XPC_SERVICE_NAME': '0', 16:15:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:55 INFO - Downloading/unpacking flake8 16:15:55 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 16:15:55 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 16:15:55 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 16:15:55 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 16:15:55 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 16:15:55 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 16:15:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:15:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:15:58 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 16:15:58 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 16:15:58 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 16:15:58 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 16:15:58 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 16:15:58 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 16:15:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:15:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:15:58 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 16:15:58 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 16:15:58 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 16:15:58 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 16:15:58 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 16:15:58 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 16:15:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:15:59 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 16:15:59 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 16:15:59 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 16:15:59 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 16:15:59 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 16:15:59 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 16:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:15:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:15:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:15:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:15:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:15:59 INFO - no previously-included directories found matching 'docs/_build' 16:15:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:15:59 INFO - Running setup.py install for pep8 16:15:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:15:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:15:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:15:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:15:59 INFO - no previously-included directories found matching 'docs/_build' 16:15:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:15:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:15:59 INFO - Cleaning up... 16:16:00 INFO - Return code: 0 16:16:00 INFO - Running post-action listener: _resource_record_post_action 16:16:00 INFO - Running post-action listener: _start_resource_monitoring 16:16:00 INFO - Starting resource monitoring. 16:16:00 INFO - ##### 16:16:00 INFO - ##### Running install step. 16:16:00 INFO - ##### 16:16:00 INFO - Running pre-action listener: _resource_record_pre_action 16:16:00 INFO - Running main action method: install 16:16:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:16:00 INFO - Reading from file tmpfile_stdout 16:16:00 INFO - Detecting whether we're running mozinstall >=1.0... 16:16:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:16:00 INFO - Reading from file tmpfile_stdout 16:16:00 INFO - Output received: 16:16:00 INFO - Usage: mozinstall [options] installer 16:16:00 INFO - Options: 16:16:00 INFO - -h, --help show this help message and exit 16:16:00 INFO - -d DEST, --destination=DEST 16:16:00 INFO - Directory to install application into. [default: 16:16:00 INFO - "/builds/slave/test"] 16:16:00 INFO - --app=APP Application being installed. [default: firefox] 16:16:00 INFO - mkdir: /builds/slave/test/build/application 16:16:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 16:16:32 INFO - Reading from file tmpfile_stdout 16:16:32 INFO - Output received: 16:16:32 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:16:32 INFO - Running post-action listener: _resource_record_post_action 16:16:32 INFO - ##### 16:16:32 INFO - ##### Running run-tests step. 16:16:32 INFO - ##### 16:16:32 INFO - Running pre-action listener: _resource_record_pre_action 16:16:32 INFO - Running main action method: run_tests 16:16:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:16:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:16:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:16:32 INFO - 2016-04-05 16:16:32.910 screenresolution[1641:7709] starting screenresolution argv=screenresolution get 16:16:32 INFO - 2016-04-05 16:16:32.912 screenresolution[1641:7709] Display 0: 1600x1200x32@60 16:16:32 INFO - 2016-04-05 16:16:32.918 screenresolution[1642:7711] starting screenresolution argv=screenresolution list 16:16:32 INFO - Available Modes on Display 0 16:16:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:16:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:16:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:16:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:16:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:16:33 INFO - Intel Iris: 16:16:33 INFO - Chipset Model: Intel Iris 16:16:33 INFO - Type: GPU 16:16:33 INFO - Bus: Built-In 16:16:33 INFO - VRAM (Dynamic, Max): 1536 MB 16:16:33 INFO - Vendor: Intel (0x8086) 16:16:33 INFO - Device ID: 0x0a2e 16:16:33 INFO - Revision ID: 0x0009 16:16:33 INFO - Displays: 16:16:33 INFO - Display: 16:16:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:16:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:16:33 INFO - Display Serial Number: 1600x1200 60 16:16:33 INFO - Main Display: Yes 16:16:33 INFO - Mirror: Off 16:16:33 INFO - Online: Yes 16:16:33 INFO - Rotation: Supported 16:16:33 INFO - Return code: 0 16:16:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:16:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:16:33 INFO - Python 2.7.3 16:16:33 INFO - Return code: 0 16:16:33 INFO - grabbing minidump binary from tooltool 16:16: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')]} 16:16:33 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 0x101c9bd30>, '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 0x101affdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c92b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:16:33 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 16:16:33 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 16:16:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:16:33 INFO - Return code: 0 16:16:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:16:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:16:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:16:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:16:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:16:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:16:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:16:34 INFO - Return code: 0 16:16:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0100 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:16:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P11fffXo2d/Render', 16:16:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:34 INFO - 'HOME': '/Users/cltbld', 16:16:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:34 INFO - 'LOGNAME': 'cltbld', 16:16:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:16:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:34 INFO - 'MOZ_NO_REMOTE': '1', 16:16:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:16:34 INFO - 'NO_EM_RESTART': '1', 16:16:34 INFO - 'PAGER': '/bin/cat', 16:16:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:34 INFO - 'PWD': '/builds/slave/test', 16:16:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:16:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:34 INFO - 'SHELL': '/bin/bash', 16:16:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zo640JgX4B/Listeners', 16:16:34 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 16:16:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:34 INFO - 'USER': 'cltbld', 16:16:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:34 INFO - 'XPC_FLAGS': '0x0', 16:16:34 INFO - 'XPC_SERVICE_NAME': '0', 16:16:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:16:34 INFO - mozversion application_buildid: 20160405142117 16:16:34 INFO - mozversion application_changeset: 6ebd54f5ed82ae5d85d45328939c783c27b5b77b 16:16:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:16:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:16:34 INFO - mozversion application_name: Firefox 16:16:34 INFO - mozversion application_remotingname: firefox-dev 16:16:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:16:34 INFO - mozversion application_vendor: Mozilla 16:16:34 INFO - mozversion application_version: 47.0a2 16:16:34 INFO - mozversion platform_buildid: 20160405142117 16:16:34 INFO - mozversion platform_changeset: 6ebd54f5ed82ae5d85d45328939c783c27b5b77b 16:16:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:16:34 INFO - mozversion platform_version: 47.0a2 16:16:34 INFO - using testdate: 1459898194 16:16:34 INFO - actual date: 1459898194 16:16:34 INFO - starting webserver on 'localhost:49275' 16:16:34 INFO - SUITE-START | Running 2 tests 16:16:34 INFO - TEST-START | dromaeo_css 16:16:34 INFO - operating with platform_type : mac_ 16:16:34 INFO - Initialising browser for dromaeo_css test... 16:16:34 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmp4RWYpO/profile http://localhost:49275/getInfo.html) 16:16:37 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 16:16:37 INFO - PROCESS | 1660 | colorDepth:24 16:16:37 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 16:16:37 INFO - PROCESS | 1660 | __metrics 16:16:37 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:16:37 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:16:37 INFO - TEST-INFO | 1660: exit 0 16:16:37 INFO - Browser initialized. 16:16:37 INFO - Running cycle 1/1 for dromaeo_css test... 16:16:37 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmp4RWYpO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:16:49 INFO - PROCESS | 1662 | RSS: Main: 207638528 16:16:49 INFO - PROCESS | 1662 | 16:17:40 INFO - PROCESS | 1662 | 1459898260604 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] 16:19:50 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 16:19:51 INFO - PROCESS | 1662 | RSS: Main: 322625536 16:19:51 INFO - PROCESS | 1662 | 16:22:54 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 16:22:54 INFO - PROCESS | 1662 | RSS: Main: 334352384 16:22:54 INFO - PROCESS | 1662 | 16:25:56 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 16:25:57 INFO - PROCESS | 1662 | RSS: Main: 340545536 16:25:57 INFO - PROCESS | 1662 | 16:28:59 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 16:29:00 INFO - PROCESS | 1662 | RSS: Main: 302096384 16:29:00 INFO - PROCESS | 1662 | 16:32:03 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 16:32:03 INFO - PROCESS | 1662 | RSS: Main: 306540544 16:32:03 INFO - PROCESS | 1662 | 16:35:06 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 16:35:06 INFO - PROCESS | 1662 | RSS: Main: 412430336 16:35:06 INFO - PROCESS | 1662 | 16:35:06 INFO - PROCESS | 1662 | __start_tp_report 16:35:06 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 16:35:06 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 16:35:06 INFO - PROCESS | 1662 | |i|pagename|runs| 16:35:06 INFO - PROCESS | 1662 | |0;dojo.html;2966.3474035712147;3429.1769975205953;3499.8075105869184;3531.364354416204;3560.6439356064398;5695.288088988871;5706.400827913067;5708.486236238738;5713.8285851424525;5721.542276617871;5697.772089116441;5748.655080695151;5756.02147634902;5759.971200144004;5763.221965034719;5104.540591346797;5135.537801597856;5139.25480805283;5220.973895130519;5221.660592061523;5247.003069416818;5247.763850626731;5251.711155886424;5257.027449921758;5258.789648414078;5161.406438259592;5210.76551555181;5219.947800521984;5235.55497782689;5247.658902171346;5239.952009598077;5271.525562699357;5281.155015197588;5285.2600635911;5315.521603055705;4993.625478089158;5173.8189163379475;5186.24799404088;5191.792328306901;5195.3246078009615;5622.971885140589;5653.632513886584;5666.433356664301;5680.602357834953;5697.430256974311;6081.908771368433;6273.341299163568;6289.748410063592;6291.307956124822;6293.811185664437;6154.938450615526;6195.969020154916;6209.658468784215;6272.1219029335925;6286.4342209201395;5806.44838740319;5813.418658134195;5832.154337621021;5832.475077243069;5871.2073870027;6165.907511387333;6197.318294987548;6285.5600107992;6288.654124023131;6292.528060395397;6129.603311142676;6159.23009623797;6159.876802463926;6170.413810687977;6170.969145154246;6277.968610157011;6278.717457714414;6283.905741413882;6290.779822706275;6291.6854157291955;5980.282366116007;6130.054126861426;6148.9692551536955;6226.346233645402;6233.501319894398;6191.4118158774845;6218.875622487525;6225.501959843292;6246.063090536365;6258.968705156536;4865.829695960624;4867.683600565952;4875.366202393666;4883.877903052452;4898.657094003457;4331.047169622678;4367.541408152162;4439;4449.466064072332;4460.219461594208;5738.454846789548;5764.913526297109;5766.711664416763;5770.076787713946;5821.126830975388;6303.6532990685955;6305.369463053658;6306.590071645328;6309.716062777186;6325.304216536178;4582.610478109398;5603.719814009283;5680.943190568124;5750.02249617566;5756.251687280626;5346.091164502044;5385.569154467633;5402.270693456412;5403.081476149064;5407.405185429599;6313.652749098844;6358.205224346957;6377.96811015942;6378.553501254868;6386.776462823779;6147.84630384244;6234.719437625408;6276.748930042747;6315.684215789284;6337.144485494399;5635.0138725723655;6019.6990150493175;6343.3022367538615;6346.746130154742;6354.968225158845;6186.443220110212;6194.659293738888;6195;6214.9689251553455;6216.378362163748;6144.8771024580155;6187.752489900534;6253.155823963707;6271.4669253114;6326;4859.198232291774;5904.261967254093;6094.451499364901;6112.449879510866;6117.84705382369;5871.853203669943;6103.931811932983;6106.2061931948565;6121.602095863755;6131.816045518642;5895.882082358415;5985.970070149621;5988.520918326611;5995.040793473024;6015.097735339734;6126.938730612636;6155.322914479493;6161.291451482957;6166.414190651881;6173.259208894961;5797.246357973605;5901.557383196192;5995.790147344822;6011.909821352596;6012.939870601413 16:35:06 INFO - PROCESS | 1662 | |1;ext.html;482.0431443584482;558.9608727389082;587.3187102960567;670.661316035402;677.6886724188695;31271.843640781794;39048.609513904856;39365;39382.40926386107;39459.80270098645;42249.36625950613;42840.71477855661;42890.78554607223;42909;42965.570344296546;9608.039196080406;9845.11393974542;9849.212063034976;9854.556544955458;9870.259730520203;9596.32825702201;9760.4631745254;9763.511824408786;9769.218462522982;9775.951120244388;9717.708468745914;9760.975097614755;9783.706488805312;9784.070513301225;9786.902130978706;8590;9855.359401638907;9931.602735890556;9942.154916832078;9964.451955142464;9676;9783.706488805276;9785.11933925943;9819.312648114636;9829.606815727362;41522.1695566087;41718;41760.164796703895;41840.16319673589;41865.1626967462;3060.816351018946;3230.2570408805873;3361.243720162968;3373.848176832024;3862.9183828528057;28161.43677126446;28896;28942.42115157685;29598.70401295981;29693.554596681068;2792.539231026878;2806.410653762712;2834.1214223590755;2887.206018344972;2888.364559796841;394699;395501;396037.0198148991;399048;399116;46100.07799843985;54648.72675636596;67532.3246767526;67556.94658320516;67621.98567021498;45575.31637025381;45848.770756146005;45869.7706511472;45979;45979.54020459753;16263.024218546925;16461.423850165185;16477.505674829776;16480.587985300222;16503.752443713354;13143.934280328536;13167.60497185086;13204.60386188416;13219.94240460761;13234.801477977839;14765.187914664797;14776.965612407243;15066.322015509328;15098.698026039418;15230;6396;6504.349565043458;6536.8365790855605;6552.770653027121;6568.376004279586;968.1770495079268;1004.7036124343336;1004.8894621591766;1011.1657882247175;1022.1414012229762;25124.623130653054;25310.493790124096;29581;30357.089287321414;30434.54348184779;1142.3260276436943;1146.5356530605118;1210.1347536511437;1258.7985922252396;1316.6642506161058;11287.661370158909;14540.709185816437;15717.449889253821;15862.682746345008;15904.045757254602;509436;514719.8528014747;514867;515835;518926.40536797076;50082.24876626854;59876.503087422294;60355.69822150861;60396.39603603996;60420.09369859456;1467.5670677150054;1498.355707045959;1544.6910617876244;1548.5276990518;1552.0299812617113;28596.142115736562;28907.132786016453;29080.127596172148;29473.263168420963;29584.964526241478;47034.82412939567;57961;59235.703821480616;59245.70377148087;59383.81232375242;407357;410127;412820;413503;415011;37276.06809829776;43531.78234108936;43613.78193109141;44137.33793993157;45289.773551132035;42776.50282240107;43216.567834322515;43482.91292717581;44703;44772.55227447684;32836.50745238871;34597.48103778395;34699.826500868345;35483;37200.81399593093;29789.808407664317;33534.49698254577;36090.63909360873;36430;37055.8147209273;38206.85379438621;38487;38518.614813852626;38728;39492.40761388524;30918;31611.84194079015;31798.841005794824;31960;31976.36047279088;24323;24330.148444805054;25064.624030639192;25559.74440255648;25610.871945640152 16:35:06 INFO - PROCESS | 1662 | |2;jquery.html;377.43950233902655;384.7268439408022;387.128959840359;387.2468049643441;387.6491774943676;19750.25993761496;20228;20402.795972040276;20758.584828303425;20758.792412075876;20404.387868363974;21152.153913843467;21199.364019079454;21458.356249312506;21498;5824.155497452877;6014.30835453924;6029.1257767623665;6034.064719968412;6064.514838812885;5352.892942141155;5542;5758.42415758425;5794.6523208607405;5804.361520232771;5743.913841292384;5758.712064396785;5767.711614419283;5785.27684039495;5802.680852553108;5622.606417550753;5884.852878678024;5886.17593536903;5895.675737834417;5915.319738230116;5552.305961754781;5608.355039170466;5608.355039170507;5629.296337957755;5631.831045068655;13481.730365392637;13831.79252311216;13870.514531991434;13878.306084695825;13887.79168312476;2145.6888751131;2226.6882636430914;2385.4871202691506;2621.7116117227088;2863.7708983281286;10113.595456181743;10222.386656800616;10556.10273126785;11657.766844663143;15190.924045379812;1665.2839279109978;1725.775649165613;1739.391213075426;1777.306850328373;1878.229925730444;78050.04874878116;100631;127264;127424;127609.08586371304;8956.83561137048;10663.200259980533;11469.483873225725;11521.596744113916;11615.941920290345;14266.785998210034;14279.428822847178;14323.85676143246;14330.641733956525;14343.282835858374;8628.827423451496;8795.604197811113;8804.47173169599;8866.157715017063;8913.197812196933;8916.15296546827;8935.642574297086;8941.642334306554;9010.59452324647;9016.59425325862;4041.515018197835;4287.399764033038;4402.471703395613;4471.6869819113;4533.909321813545;1861.6090620969749;1894.886306821595;1902.6289873474816;1919.9281150159634;1934.429343343717;761.9657115429708;877.6533269358567;927.2720914082548;1028.4806172882795;1041.1566631028738;19713.50716232077;20536.07587658529;20595.176192952113;20646.070926808028;20657.793422065588;977.4428575711776;987.5013118375318;990.6384169777979;1005.6731562242301;1049.905508504223;10595.94702026485;11145.49845256949;11178.832317515244;11198.272112312674;11207.935246151603;606760;618650;637195;647422;651791;67458;91183.80856669985;92521;117481.82518174879;128383.35808320898;1018.383877753963;1023.8976102389702;1040.765827688749;1044.4621020174616;1048.6853943816825;18692.158852851928;18764.96792676416;18974.525636859187;19056.142473588443;19182.242290440867;38874;43687.12625747404;51983.48016519786;54056.72971635117;55340.72329638326;71055.28944710486;71472.21319467055;74341.62829186035;74531;80016.19983800087;7957.8408431832195;7964.9203507966495;8091.55496447701;8228.917710822816;8280.71017514384;9364.344495885223;10775.245732798629;12604.11771176009;13047.412866421224;13450;11213.55145794159;11501.309921404743;11761.47073381717;11824.408779560816;11920.105992050805;10219.386836789816;11411.942940285246;11465.828012579652;11633.825492617449;11835.408229588314;11177.161712871404;11251.381174035507;11564.710882228012;11618.244814087057;12178.75642487163;8484.278836298738;11100.944495277472;11289.153313501685;11570.305781653127;12122.27266364021;11305.830412543653;12276.631701048982;12312.81530777057;12373.195742276723;12450.688732781753 16:35:06 INFO - PROCESS | 1662 | |3;mootools.html;1427.9000469967107;1620.781194538737;1655.172413793103;1972.7336809530718;2063.5150739576206;8249.463784853988;8898.866517002241;9104.044075372081;9120.999999999984;9126.406783559063;8868.866966995483;8898;9017.143371379725;9023.72928812135;9031.638734450615;2227.7301937895404;2460.987695061531;2517.8237523373373;2537.188099808053;2537.3783423061377;2539.2382285314334;2546.8471891686468;2547.821652484327;2552.9489410211786;2556.6165075238678;2471.7775400213977;2509;2560.8463492190435;2565.9743402565923;2566.5636841736855;2326.569159966625;2339.4034521196986;2534.1510593951048;2552.7574880386333;2559.795216382685;2494.4262819551423;2521.420073383114;2529.3297276221815;2531.721510633829;2571.742825717432;9119.49842758648;9174.036726143726;9187.908120918772;9188.494632795193;9196.080391960817;5554.694491802949;5719.742611582489;5719.828405147852;5720.427957204288;5727.713614319267;3649.817509124533;3730.552333719971;3792.639699228569;3792.7345085844004;3821.522309711286;1057.7408534908996;1073.9677809665723;1082.86464191976;1090.460222190021;1106.33066994468;10499.79000419995;12607.991360691123;12612.81080783789;12634.999999999907;12656.303903285316;4227.365895115696;4937.925931111036;4992.650514463952;5093.796248150106;5112.667676601083;10624.681259562225;10628.5651437055;10632.41521716313;10642.467876606293;10643.893561064446;5775.075987841925;5776.566757493205;5794;5798.797042103506;5840.649561026267;4633.49031606523;4805.183118869731;5001.424836143818;5145.434002259748;5249.737513124329;3365.8821941232427;4066.4103704962613;4077.3068578341754;4102.384642303678;4129.958700413017;1333.9266340351373;1342.5099838558856;1347.9056466047282;1356.2337279437086;1360.0615575253044;1414.4130185972913;1446.8408475067733;1455.2432734977751;1458.1032664911004;1477.0694462488564;8579.528125953133;8633.136686331316;8680;8703.738887833248;8706.347023973227;458.31340666347495;523.9947600523946;532.6564365983919;534.6471328922893;535.1491129104742;6359.936400635935;6373.235211774524;6426.068220108058;6432.13166222554;6443.581167224115;10836.891631083747;11354.148438867118;11390.487428065757;11405.144614153805;11409.315441073562;10769.299995500267;11134.387608681438;11138.554457821596;11206.775864482664;11253.381064041556;8626.741197764077;8747.300215982834;8790.472571645594;8801.867971980426;8831.823363532694;8201.79495512617;8216.835663286582;8306.501609903426;8327.583620819056;8332.041815191089;9732.41605503672;10025.947275536255;10100.242481813746;10152.289339746147;10173.28786984904;9741.659041933499;10069.043440873398;10100.191984641358;10116.19070474375;10461.738456538647;7710.92289077102;8132.959335203286;8464.322854171774;8473.49159050459;8481.618327175169;7219.314165154302;8569.228769410784;8632.223099921037;8632.784180395289;8657.696980605648;7408.222136675571;7498;7564.281393267631;7597;7642.5032372895585;7299.5620262784405;7378.483506154733;7454.142773581108;7572.091349038151;7579.621018949141;6895.275996020346;8024.919750802417;8104.797380065545;8107.959460202661;8125.268725814705;6964.233934267328;7176.928230717626;7227.9638601806655;7264.673089711081;7266.818329541592;7313.670884810303;7340;7354.264573542603;7379.963100184465;7381.298776616213 16:35:06 INFO - PROCESS | 1662 | |4;prototype.html;302.50691373061903;319.25931838135523;331.9883804066858;336.27700444045314;339.83348159401885;6650.9667451662735;6666.433353164987;6715.2277488088885;6719.294474080224;6728;6579.473642108632;6579.506537009719;6588.407043366096;6611.504137189718;6631.336866313366;3629.909252268688;3898.654964037417;4659.6505262105475;4892.363992680965;4924.458309585952;4862.854114376574;4876.366072410599;4890.193118135503;4896.436909755388;4916.606671466274;4799.088173247089;4813.90372192556;4820.252860806563;4840.854774356775;4859.052484765472;4608.193566125931;4724.409448818915;4825;4832.758362081881;4844.951550484485;4123.752574845519;4125.91748165038;4138.91722165558;4140;4148.605882441163;5162.45794191612;6293.968530157365;6300.779472718478;6364.172657554534;6392.4246817786625;4759.524547390285;5804.100364443518;5809.82570522885;5823.359430462646;5835.183074369592;6360.141380913564;6776.322367763233;7047.718091276342;7068.010478532958;7071.504994650377;4364.301711726141;4537.795799189044;4562.954370456286;4569.794359253809;4571;6385.457236134934;7319.59742214178;7473.663685134182;7491.25087491252;7491.475596708178;4635.327877457749;4636.86089417318;4639.791209395517;4650.395448591661;4651.441826980784;4019.1559772448113;4691.249400096037;4710.646701497401;4719.787609557578;4721.858344249678;5597.244372009808;5612.186232996192;5614.606977511617;5633.746481408347;5636.323641163087;6810.523263371616;7056.329648683367;7063.869780835042;7065.89401158983;7100.60946647929;1609.4286528282291;1614.2413065859027;1630.193054438037;1632.6734653069434;1632.71427500187;979.9167070799062;1006.3861044762689;1023.0792286941812;1028.9125424338865;1050.847627094067;6580.901286480706;6711.731530738716;6742.898856517156;6759;6779.35596118368;5670.8036053321075;6326.841828954221;7166;7388.7044518219745;7397.8150546236775;6739.528233023641;6773.119494465688;6774.559653622498;6776.288489708608;6791.830204244933;3861.8455261789777;3893.2018936118593;3902.8829135125993;3907.081835768592;3908.6286802753693;6705.362990515893;6948.374646281859;6999.600079984024;7708.653110610036;7709.575973321521;7499.2500749924575;7574.431917606202;7577.469577129658;7665.655045522964;7666.501677391063;7747.72882949094;7765;7775.844483110306;7782.49413788102;7794.766157015299;7146.857062858609;7278.490505664553;7384.704611815468;7390.482666213314;7410.6665200065045;7219.639018049182;7263.6005019724425;7291;7296.233895440902;7302.853942921218;7749.883751743616;7751.8837217442915;7763.61181940912;7770.650320735694;7775.261350171724;4616.930746038879;4632.5135860734135;4647.604953578983;4658.347831303552;4658.487566367629;7069.469789765891;7347.485676002629;7355.411567074728;7360.300771426706;7362.558246505227;7068.893966590403;7099.858002840017;7116.501844871016;7122.5726456412785;7123.536970096927;7086.255943125898;7089.893651595334;7094.716211351488;7096.432285417051;7102.715891364288;6894.689738961659;6894.689738961659;6894.8621027580175;6897.275786042594;6913.343232392915;6830.863382732218;7086.822829429306;7102.786916392516;7105.32499412555;7114.928850711427;6595.967020164869;6699.162604674416;6774;6918.515703900679;6973.5118541701595 16:35:06 INFO - PROCESS | 1662 | |5;yui.html;684.6953105867891;715.9606221657809;775.5501808950809;779.9844003119935;790.3913986230602;15075.170865602387;15417.614559636;15440.69118617627;15456.459023934165;15526.922365388158;13801.861981380183;13871.861281387182;13878.722425551483;13897.444102235899;13921.02552821303;790.5651891459703;797.8165022044933;941.1811723800304;954.4893481987156;978.4178413843787;952.1811242331589;962.523550842334;966.9033096690345;968.0561452583745;969.1955676788284;1040.2926010313022;1047.005344922323;1047.5495536919123;1047.9004494573041;1049.0139269087033;842.7640260727006;996.6013594562161;1027.8972102789735;1029.3875144289136;1032.0814475117152;766.5745511241258;767.0833354141803;767.5394763142126;767.6967597798894;768.6195333310047;14884.776728349083;14951.102933824006;14965.925170374187;14980.176090315028;15035.54893353201;12749.53380361261;13259;13414.195148291035;13542.45830166802;13554.322283885866;9828;11172.217944743872;11200.439978001068;11508.482118304697;11666.766664666744;2909.7963142579815;3537.0980399998093;3575.535180426528;3607.260511595117;3781.092537790938;84316.73524897131;84332.57833710792;84601.73097403544;84909.57545212297;89044;9248.583813728399;9330.066993300616;9559.569819358145;9594.568244429018;10094.394336339843;17999.460016199537;21947.67078493824;21963.791991440303;22006;22017.449563760714;6245.906311405332;7546.434017448713;7650.464467487333;7739.690412383554;8033.718819841278;4050.25070361984;4151.97924010378;4167.041580436517;4234.640055595309;4396.60430561251;3732.850685972585;3784.413415920537;3800.3919372900205;3812.7140464465274;3814.5422549294262;565.1550931357565;581.2385774635242;659.1760299625469;671.7010930136042;696.216756149332;548.62419242818;576.2278546747295;597.3309892919957;618.3816183816184;631.643121636274;7063.57618542889;8278.586070696441;8493.320534357237;8494.787630309293;8651.78370540729;527.8574784808158;554.5314209492972;591.2284468768213;603.6167033933484;622.2035794183453;3818.694504439694;3933.645971862546;3985.222881538072;3988.8603898863403;4041.9288888444585;90577;91052.5447372759;91434.08565914255;91747.62378564327;91832;79257.20742792613;79435.41129177384;79856.80214796783;80859;81263.5936820324;73135.63432182911;73369.26630733837;74774.38289659836;75925.24074759292;78195.60902195566;7880.487768295043;7989.520628762293;8147.348212142896;8157.75526734199;8304.501729896225;49395.75302123466;49935.25097123473;51805;51974.96050079053;52090.47909520856;66107;69581;71885.6405717989;72597.63701181671;73912;10244.02681745233;10350.948245258725;11163.162762792661;11436.199466037298;11754.76490470203;11978.221415607957;12028.398580071136;12099.81850272229;12180.512779488721;13211.471541138248;11344.262622929813;11494;11581.536738530365;11612.303261804318;11659.76680466369;11334.263272887236;11560.94219528897;11623.6512904613;11846;12214.267143971034;11393.601223957121;11492.770144597229;11699.064074873819;11731.88268117308;12075.75848483043;9517.670857958805;9549.570269338035;9702.078302561245;9993.250506212209;10087.344322619007;9094.545272736468;9633.807323853343;9847.212223021997;9889.25830562725;9896.059874311928 16:35:06 INFO - PROCESS | 1662 | __end_tp_report 16:35:06 INFO - PROCESS | 1662 | __start_cc_report 16:35:06 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1004 16:35:06 INFO - PROCESS | 1662 | __end_cc_report 16:35:06 INFO - PROCESS | 1662 | __startTimestamp1459899306771__endTimestamp 16:35:06 INFO - PROCESS | 1662 | 16:35:06 INFO - PROCESS | 1662 | ------- Summary: start ------- 16:35:06 INFO - PROCESS | 1662 | Number of tests: 6 16:35:06 INFO - PROCESS | 1662 | 16:35:06 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5737.42 Median:5980.28 stddev:649.98 (10.9%) stddev-sans-first:614.55 16:35:06 INFO - PROCESS | 1662 | Values: 2966.3 3429.2 3499.8 3531.4 3560.6 5695.3 5706.4 5708.5 5713.8 5721.5 5697.8 5748.7 5756.0 5760.0 5763.2 5104.5 5135.5 5139.3 5221.0 5221.7 5247.0 5247.8 5251.7 5257.0 5258.8 5161.4 5210.8 5219.9 5235.6 5247.7 5240.0 5271.5 5281.2 5285.3 5315.5 4993.6 5173.8 5186.2 5191.8 5195.3 5623.0 5653.6 5666.4 5680.6 5697.4 6081.9 6273.3 6289.7 6291.3 6293.8 6154.9 6196.0 6209.7 6272.1 6286.4 5806.4 5813.4 5832.2 5832.5 5871.2 6165.9 6197.3 6285.6 6288.7 6292.5 6129.6 6159.2 6159.9 6170.4 6171.0 6278.0 6278.7 6283.9 6290.8 6291.7 5980.3 6130.1 6149.0 6226.3 6233.5 6191.4 6218.9 6225.5 6246.1 6259.0 4865.8 4867.7 4875.4 4883.9 4898.7 4331.0 4367.5 4439.0 4449.5 4460.2 5738.5 5764.9 5766.7 5770.1 5821.1 6303.7 6305.4 6306.6 6309.7 6325.3 4582.6 5603.7 5680.9 5750.0 5756.3 5346.1 5385.6 5402.3 5403.1 5407.4 6313.7 6358.2 6378.0 6378.6 6386.8 6147.8 6234.7 6276.7 6315.7 6337.1 5635.0 6019.7 6343.3 6346.7 6355.0 6186.4 6194.7 6195.0 6215.0 6216.4 6144.9 6187.8 6253.2 6271.5 6326.0 4859.2 5904.3 6094.5 6112.4 6117.8 5871.9 6103.9 6106.2 6121.6 6131.8 5895.9 5986.0 5988.5 5995.0 6015.1 6126.9 6155.3 6161.3 6166.4 6173.3 5797.2 5901.6 5995.8 6011.9 6012.9 16:35:06 INFO - PROCESS | 1662 | 16:35:06 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:59161.57 Median:217496.70 stddev:117798.79 (54.2%) stddev-sans-first:118046.86 16:35:06 INFO - PROCESS | 1662 | Values: 482.0 559.0 587.3 670.7 677.7 31271.8 39048.6 39365.0 39382.4 39459.8 42249.4 42840.7 42890.8 42909.0 42965.6 9608.0 9845.1 9849.2 9854.6 9870.3 9596.3 9760.5 9763.5 9769.2 9776.0 9717.7 9761.0 9783.7 9784.1 9786.9 8590.0 9855.4 9931.6 9942.2 9964.5 9676.0 9783.7 9785.1 9819.3 9829.6 41522.2 41718.0 41760.2 41840.2 41865.2 3060.8 3230.3 3361.2 3373.8 3862.9 28161.4 28896.0 28942.4 29598.7 29693.6 2792.5 2806.4 2834.1 2887.2 2888.4 394699.0 395501.0 396037.0 399048.0 399116.0 46100.1 54648.7 67532.3 67556.9 67622.0 45575.3 45848.8 45869.8 45979.0 45979.5 16263.0 16461.4 16477.5 16480.6 16503.8 13143.9 13167.6 13204.6 13219.9 13234.8 14765.2 14777.0 15066.3 15098.7 15230.0 6396.0 6504.3 6536.8 6552.8 6568.4 968.2 1004.7 1004.9 1011.2 1022.1 25124.6 25310.5 29581.0 30357.1 30434.5 1142.3 1146.5 1210.1 1258.8 1316.7 11287.7 14540.7 15717.4 15862.7 15904.0 509436.0 514719.9 514867.0 515835.0 518926.4 50082.2 59876.5 60355.7 60396.4 60420.1 1467.6 1498.4 1544.7 1548.5 1552.0 28596.1 28907.1 29080.1 29473.3 29585.0 47034.8 57961.0 59235.7 59245.7 59383.8 407357.0 410127.0 412820.0 413503.0 415011.0 37276.1 43531.8 43613.8 44137.3 45289.8 42776.5 43216.6 43482.9 44703.0 44772.6 32836.5 34597.5 34699.8 35483.0 37200.8 29789.8 33534.5 36090.6 36430.0 37055.8 38206.9 38487.0 38518.6 38728.0 39492.4 30918.0 31611.8 31798.8 31960.0 31976.4 24323.0 24330.1 25064.6 25559.7 25610.9 16:35:06 INFO - PROCESS | 1662 | 16:35:06 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:34651.10 Median:20708.19 stddev:104624.49 (505.2%) stddev-sans-first:104886.34 16:35:06 INFO - PROCESS | 1662 | Values: 377.4 384.7 387.1 387.2 387.6 19750.3 20228.0 20402.8 20758.6 20758.8 20404.4 21152.2 21199.4 21458.4 21498.0 5824.2 6014.3 6029.1 6034.1 6064.5 5352.9 5542.0 5758.4 5794.7 5804.4 5743.9 5758.7 5767.7 5785.3 5802.7 5622.6 5884.9 5886.2 5895.7 5915.3 5552.3 5608.4 5608.4 5629.3 5631.8 13481.7 13831.8 13870.5 13878.3 13887.8 2145.7 2226.7 2385.5 2621.7 2863.8 10113.6 10222.4 10556.1 11657.8 15190.9 1665.3 1725.8 1739.4 1777.3 1878.2 78050.0 100631.0 127264.0 127424.0 127609.1 8956.8 10663.2 11469.5 11521.6 11615.9 14266.8 14279.4 14323.9 14330.6 14343.3 8628.8 8795.6 8804.5 8866.2 8913.2 8916.2 8935.6 8941.6 9010.6 9016.6 4041.5 4287.4 4402.5 4471.7 4533.9 1861.6 1894.9 1902.6 1919.9 1934.4 762.0 877.7 927.3 1028.5 1041.2 19713.5 20536.1 20595.2 20646.1 20657.8 977.4 987.5 990.6 1005.7 1049.9 10595.9 11145.5 11178.8 11198.3 11207.9 606760.0 618650.0 637195.0 647422.0 651791.0 67458.0 91183.8 92521.0 117481.8 128383.4 1018.4 1023.9 1040.8 1044.5 1048.7 18692.2 18765.0 18974.5 19056.1 19182.2 38874.0 43687.1 51983.5 54056.7 55340.7 71055.3 71472.2 74341.6 74531.0 80016.2 7957.8 7964.9 8091.6 8228.9 8280.7 9364.3 10775.2 12604.1 13047.4 13450.0 11213.6 11501.3 11761.5 11824.4 11920.1 10219.4 11411.9 11465.8 11633.8 11835.4 11177.2 11251.4 11564.7 11618.2 12178.8 8484.3 11100.9 11289.2 11570.3 12122.3 11305.8 12276.6 12312.8 12373.2 12450.7 16:35:06 INFO - PROCESS | 1662 | 16:35:06 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:6282.90 Median:5103.23 stddev:3353.13 (65.7%) stddev-sans-first:3342.67 16:35:06 INFO - PROCESS | 1662 | Values: 1427.9 1620.8 1655.2 1972.7 2063.5 8249.5 8898.9 9104.0 9121.0 9126.4 8868.9 8898.0 9017.1 9023.7 9031.6 2227.7 2461.0 2517.8 2537.2 2537.4 2539.2 2546.8 2547.8 2552.9 2556.6 2471.8 2509.0 2560.8 2566.0 2566.6 2326.6 2339.4 2534.2 2552.8 2559.8 2494.4 2521.4 2529.3 2531.7 2571.7 9119.5 9174.0 9187.9 9188.5 9196.1 5554.7 5719.7 5719.8 5720.4 5727.7 3649.8 3730.6 3792.6 3792.7 3821.5 1057.7 1074.0 1082.9 1090.5 1106.3 10499.8 12608.0 12612.8 12635.0 12656.3 4227.4 4937.9 4992.7 5093.8 5112.7 10624.7 10628.6 10632.4 10642.5 10643.9 5775.1 5776.6 5794.0 5798.8 5840.6 4633.5 4805.2 5001.4 5145.4 5249.7 3365.9 4066.4 4077.3 4102.4 4130.0 1333.9 1342.5 1347.9 1356.2 1360.1 1414.4 1446.8 1455.2 1458.1 1477.1 8579.5 8633.1 8680.0 8703.7 8706.3 458.3 524.0 532.7 534.6 535.1 6359.9 6373.2 6426.1 6432.1 6443.6 10836.9 11354.1 11390.5 11405.1 11409.3 10769.3 11134.4 11138.6 11206.8 11253.4 8626.7 8747.3 8790.5 8801.9 8831.8 8201.8 8216.8 8306.5 8327.6 8332.0 9732.4 10025.9 10100.2 10152.3 10173.3 9741.7 10069.0 10100.2 10116.2 10461.7 7710.9 8133.0 8464.3 8473.5 8481.6 7219.3 8569.2 8632.2 8632.8 8657.7 7408.2 7498.0 7564.3 7597.0 7642.5 7299.6 7378.5 7454.1 7572.1 7579.6 6895.3 8024.9 8104.8 8108.0 8125.3 6964.2 7176.9 7228.0 7264.7 7266.8 7313.7 7340.0 7354.3 7380.0 7381.3 16:35:06 INFO - PROCESS | 1662 | 16:35:06 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:5762.68 Median:6658.70 stddev:1867.71 (28.0%) stddev-sans-first:1827.43 16:35:06 INFO - PROCESS | 1662 | Values: 302.5 319.3 332.0 336.3 339.8 6651.0 6666.4 6715.2 6719.3 6728.0 6579.5 6579.5 6588.4 6611.5 6631.3 3629.9 3898.7 4659.7 4892.4 4924.5 4862.9 4876.4 4890.2 4896.4 4916.6 4799.1 4813.9 4820.3 4840.9 4859.1 4608.2 4724.4 4825.0 4832.8 4845.0 4123.8 4125.9 4138.9 4140.0 4148.6 5162.5 6294.0 6300.8 6364.2 6392.4 4759.5 5804.1 5809.8 5823.4 5835.2 6360.1 6776.3 7047.7 7068.0 7071.5 4364.3 4537.8 4563.0 4569.8 4571.0 6385.5 7319.6 7473.7 7491.3 7491.5 4635.3 4636.9 4639.8 4650.4 4651.4 4019.2 4691.2 4710.6 4719.8 4721.9 5597.2 5612.2 5614.6 5633.7 5636.3 6810.5 7056.3 7063.9 7065.9 7100.6 1609.4 1614.2 1630.2 1632.7 1632.7 979.9 1006.4 1023.1 1028.9 1050.8 6580.9 6711.7 6742.9 6759.0 6779.4 5670.8 6326.8 7166.0 7388.7 7397.8 6739.5 6773.1 6774.6 6776.3 6791.8 3861.8 3893.2 3902.9 3907.1 3908.6 6705.4 6948.4 6999.6 7708.7 7709.6 7499.3 7574.4 7577.5 7665.7 7666.5 7747.7 7765.0 7775.8 7782.5 7794.8 7146.9 7278.5 7384.7 7390.5 7410.7 7219.6 7263.6 7291.0 7296.2 7302.9 7749.9 7751.9 7763.6 7770.7 7775.3 4616.9 4632.5 4647.6 4658.3 4658.5 7069.5 7347.5 7355.4 7360.3 7362.6 7068.9 7099.9 7116.5 7122.6 7123.5 7086.3 7089.9 7094.7 7096.4 7102.7 6894.7 6894.7 6894.9 6897.3 6913.3 6830.9 7086.8 7102.8 7105.3 7114.9 6596.0 6699.2 6774.0 6918.5 6973.5 16:35:06 INFO - PROCESS | 1662 | 16:35:06 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:18812.02 Median:551.58 stddev:26539.61 (4811.6%) stddev-sans-first:26579.15 16:35:06 INFO - PROCESS | 1662 | Values: 684.7 716.0 775.6 780.0 790.4 15075.2 15417.6 15440.7 15456.5 15526.9 13801.9 13871.9 13878.7 13897.4 13921.0 790.6 797.8 941.2 954.5 978.4 952.2 962.5 966.9 968.1 969.2 1040.3 1047.0 1047.5 1047.9 1049.0 842.8 996.6 1027.9 1029.4 1032.1 766.6 767.1 767.5 767.7 768.6 14884.8 14951.1 14965.9 14980.2 15035.5 12749.5 13259.0 13414.2 13542.5 13554.3 9828.0 11172.2 11200.4 11508.5 11666.8 2909.8 3537.1 3575.5 3607.3 3781.1 84316.7 84332.6 84601.7 84909.6 89044.0 9248.6 9330.1 9559.6 9594.6 10094.4 17999.5 21947.7 21963.8 22006.0 22017.4 6245.9 7546.4 7650.5 7739.7 8033.7 4050.3 4152.0 4167.0 4234.6 4396.6 3732.9 3784.4 3800.4 3812.7 3814.5 565.2 581.2 659.2 671.7 696.2 548.6 576.2 597.3 618.4 631.6 7063.6 8278.6 8493.3 8494.8 8651.8 527.9 554.5 591.2 603.6 622.2 3818.7 3933.6 3985.2 3988.9 4041.9 90577.0 91052.5 91434.1 91747.6 91832.0 79257.2 79435.4 79856.8 80859.0 81263.6 73135.6 73369.3 74774.4 75925.2 78195.6 7880.5 7989.5 8147.3 8157.8 8304.5 49395.8 49935.3 51805.0 51975.0 52090.5 66107.0 69581.0 71885.6 72597.6 73912.0 10244.0 10350.9 11163.2 11436.2 11754.8 11978.2 12028.4 12099.8 12180.5 13211.5 11344.3 11494.0 11581.5 11612.3 11659.8 11334.3 11560.9 11623.7 11846.0 12214.3 11393.6 11492.8 11699.1 11731.9 12075.8 9517.7 9549.6 9702.1 9993.3 10087.3 9094.5 9633.8 9847.2 9889.3 9896.1 16:35:06 INFO - PROCESS | 1662 | -------- Summary: end -------- 16:35:06 INFO - PROCESS | 1662 | 16:35:07 INFO - TEST-INFO | 1662: exit 0 16:35:07 INFO - TEST-OK | dromaeo_css | took 1112635ms 16:35:07 INFO - TEST-START | kraken 16:35:07 INFO - operating with platform_type : mac_ 16:35:07 INFO - Initialising browser for kraken test... 16:35:07 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpioWSG9/profile http://localhost:49275/getInfo.html) 16:35:09 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 16:35:09 INFO - PROCESS | 1673 | colorDepth:24 16:35:09 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 16:35:09 INFO - PROCESS | 1673 | __metrics 16:35:09 INFO - PROCESS | 1673 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:35:09 INFO - PROCESS | 1673 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:35:09 INFO - TEST-INFO | 1673: exit 0 16:35:09 INFO - Browser initialized. 16:35:09 INFO - Running cycle 1/1 for kraken test... 16:35:09 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpioWSG9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:35:22 INFO - PROCESS | 1675 | RSS: Main: 207638528 16:35:22 INFO - PROCESS | 1675 | 16:35:24 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 16:35:25 INFO - PROCESS | 1675 | RSS: Main: 262926336 16:35:25 INFO - PROCESS | 1675 | 16:35:27 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 16:35:28 INFO - PROCESS | 1675 | RSS: Main: 273297408 16:35:28 INFO - PROCESS | 1675 | 16:35:31 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 16:35:32 INFO - PROCESS | 1675 | RSS: Main: 263806976 16:35:32 INFO - PROCESS | 1675 | 16:35:33 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 16:35:34 INFO - PROCESS | 1675 | RSS: Main: 264937472 16:35:34 INFO - PROCESS | 1675 | 16:35:36 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:35:37 INFO - PROCESS | 1675 | RSS: Main: 264663040 16:35:37 INFO - PROCESS | 1675 | 16:35:40 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 16:35:40 INFO - PROCESS | 1675 | RSS: Main: 265908224 16:35:40 INFO - PROCESS | 1675 | 16:35:43 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 16:35:44 INFO - PROCESS | 1675 | RSS: Main: 266002432 16:35:44 INFO - PROCESS | 1675 | 16:35:46 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 16:35:47 INFO - PROCESS | 1675 | RSS: Main: 266342400 16:35:47 INFO - PROCESS | 1675 | 16:35:49 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:35:49 INFO - PROCESS | 1675 | RSS: Main: 298827776 16:35:49 INFO - PROCESS | 1675 | 16:35:51 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:35:52 INFO - PROCESS | 1675 | RSS: Main: 299950080 16:35:52 INFO - PROCESS | 1675 | 16:35:54 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:35:54 INFO - PROCESS | 1675 | RSS: Main: 304910336 16:35:54 INFO - PROCESS | 1675 | 16:35:57 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:35:58 INFO - PROCESS | 1675 | RSS: Main: 306434048 16:35:58 INFO - PROCESS | 1675 | 16:36:00 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:36:01 INFO - PROCESS | 1675 | RSS: Main: 306532352 16:36:01 INFO - PROCESS | 1675 | 16:36:02 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 16:36:03 INFO - PROCESS | 1675 | RSS: Main: 369885184 16:36:03 INFO - PROCESS | 1675 | 16:36:03 INFO - PROCESS | 1675 | __start_tp_report 16:36:03 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 16:36:03 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 16:36:03 INFO - PROCESS | 1675 | |i|pagename|runs| 16:36:03 INFO - PROCESS | 1675 | |0;ai-astar;111;108;110;110;112;113;120;111;111;110 16:36:03 INFO - PROCESS | 1675 | |1;audio-beat-detection;155;123;151;149;117;140;118;153;146;117 16:36:03 INFO - PROCESS | 1675 | |2;audio-dft;185;185;186;183;188;185;183;186;184;187 16:36:03 INFO - PROCESS | 1675 | |3;audio-fft;74;71;76;117;56;57;57;58;114;57 16:36:03 INFO - PROCESS | 1675 | |4;audio-oscillator;91;95;129;79;80;89;105;78;106;145 16:36:03 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;87;83;88;84;86;85;88;124;81;114 16:36:03 INFO - PROCESS | 1675 | |6;imaging-darkroom;92;92;92;93;92;104;150;92;92;91 16:36:03 INFO - PROCESS | 1675 | |7;imaging-desaturate;87;85;87;83;86;85;87;101;141;117 16:36:03 INFO - PROCESS | 1675 | |8;json-parse-financial;55;57;57;57;58;58;57;68;54;51 16:36:03 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;63;61;69;79;69;68;66;67;67;72 16:36:03 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;81;95;109;105;100;80;80;80;82;84 16:36:03 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;119;120;118;117;118;119;120;135;130;132 16:36:03 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;136;124;132;132;136;122;133;130;135;132 16:36:03 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;66;66;70;82;92;63;54;87;90;91 16:36:03 INFO - PROCESS | 1675 | __end_tp_report 16:36:03 INFO - PROCESS | 1675 | __start_cc_report 16:36:03 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1242 16:36:03 INFO - PROCESS | 1675 | __end_cc_report 16:36:03 INFO - PROCESS | 1675 | __startTimestamp1459899363180__endTimestamp 16:36:03 INFO - PROCESS | 1675 | 16:36:03 INFO - PROCESS | 1675 | ------- Summary: start ------- 16:36:03 INFO - PROCESS | 1675 | Number of tests: 14 16:36:03 INFO - PROCESS | 1675 | 16:36:03 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:111.60 Median:111.00 stddev:3.24 (2.9%) stddev-sans-first:3.43 16:36:03 INFO - PROCESS | 1675 | Values: 111.0 108.0 110.0 110.0 112.0 113.0 120.0 111.0 111.0 110.0 16:36:03 INFO - PROCESS | 1675 | 16:36:03 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:136.90 Median:147.50 stddev:16.22 (11.0%) stddev-sans-first:15.82 16:36:03 INFO - PROCESS | 1675 | Values: 155.0 123.0 151.0 149.0 117.0 140.0 118.0 153.0 146.0 117.0 16:36:03 INFO - PROCESS | 1675 | 16:36:03 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:185.20 Median:185.50 stddev:1.62 (0.9%) stddev-sans-first:1.72 16:36:03 INFO - PROCESS | 1675 | Values: 185.0 185.0 186.0 183.0 188.0 185.0 183.0 186.0 184.0 187.0 16:36:03 INFO - PROCESS | 1675 | 16:36:03 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:73.70 Median:57.50 stddev:23.35 (40.6%) stddev-sans-first:24.77 16:36:03 INFO - PROCESS | 1675 | Values: 74.0 71.0 76.0 117.0 56.0 57.0 57.0 58.0 114.0 57.0 16:36:03 INFO - PROCESS | 1675 | 16:36:03 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:99.70 Median:79.50 stddev:22.31 (28.1%) stddev-sans-first:23.44 16:36:03 INFO - PROCESS | 1675 | Values: 91.0 95.0 129.0 79.0 80.0 89.0 105.0 78.0 106.0 145.0 16:36:03 INFO - PROCESS | 1675 | 16:36:03 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:92.00 Median:85.50 stddev:14.59 (17.1%) stddev-sans-first:15.36 16:36:03 INFO - PROCESS | 1675 | Values: 87.0 83.0 88.0 84.0 86.0 85.0 88.0 124.0 81.0 114.0 16:36:03 INFO - PROCESS | 1675 | 16:36:03 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:99.00 Median:92.00 stddev:18.32 (19.9%) stddev-sans-first:19.25 16:36:03 INFO - PROCESS | 1675 | Values: 92.0 92.0 92.0 93.0 92.0 104.0 150.0 92.0 92.0 91.0 16:36:03 INFO - PROCESS | 1675 | 16:36:03 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:85.50 stddev:18.99 (22.2%) stddev-sans-first:19.86 16:36:03 INFO - PROCESS | 1675 | Values: 87.0 85.0 87.0 83.0 86.0 85.0 87.0 101.0 141.0 117.0 16:36:03 INFO - PROCESS | 1675 | 16:36:03 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:4.37 (7.7%) stddev-sans-first:4.56 16:36:03 INFO - PROCESS | 1675 | Values: 55.0 57.0 57.0 57.0 58.0 58.0 57.0 68.0 54.0 51.0 16:36:03 INFO - PROCESS | 1675 | 16:36:03 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.50 stddev:4.93 (7.2%) stddev-sans-first:4.87 16:36:03 INFO - PROCESS | 1675 | Values: 63.0 61.0 69.0 79.0 69.0 68.0 66.0 67.0 67.0 72.0 16:36:03 INFO - PROCESS | 1675 | 16:36:03 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:80.50 stddev:11.50 (14.3%) stddev-sans-first:11.77 16:36:03 INFO - PROCESS | 1675 | Values: 81.0 95.0 109.0 105.0 100.0 80.0 80.0 80.0 82.0 84.0 16:36:03 INFO - PROCESS | 1675 | 16:36:03 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:122.80 Median:120.00 stddev:6.75 (5.6%) stddev-sans-first:7.01 16:36:03 INFO - PROCESS | 1675 | Values: 119.0 120.0 118.0 117.0 118.0 119.0 120.0 135.0 130.0 132.0 16:36:03 INFO - PROCESS | 1675 | 16:36:03 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:131.20 Median:132.50 stddev:4.76 (3.6%) stddev-sans-first:4.72 16:36:03 INFO - PROCESS | 1675 | Values: 136.0 124.0 132.0 132.0 136.0 122.0 133.0 130.0 135.0 132.0 16:36:03 INFO - PROCESS | 1675 | 16:36:03 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.10 Median:84.50 stddev:13.84 (16.4%) stddev-sans-first:14.18 16:36:03 INFO - PROCESS | 1675 | Values: 66.0 66.0 70.0 82.0 92.0 63.0 54.0 87.0 90.0 91.0 16:36:03 INFO - PROCESS | 1675 | -------- Summary: end -------- 16:36:03 INFO - PROCESS | 1675 | 16:36:03 INFO - TEST-INFO | 1675: exit 0 16:36:03 INFO - TEST-OK | kraken | took 56621ms 16:36:03 INFO - SUITE-END | took 1169s 16:36:04 INFO - Completed test suite (00:19:29) 16:36:04 INFO - javascript benchmark 16:36:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2966.3474035712147, 3429.1769975205953, 3499.8075105869184, 3531.364354416204, 3560.6439356064398, 5695.288088988871, 5706.400827913067, 5708.486236238738, 5713.8285851424525, 5721.542276617871, 5697.772089116441, 5748.655080695151, 5756.02147634902, 5759.971200144004, 5763.221965034719, 5104.540591346797, 5135.537801597856, 5139.25480805283, 5220.973895130519, 5221.660592061523, 5247.003069416818, 5247.763850626731, 5251.711155886424, 5257.027449921758, 5258.789648414078, 5161.406438259592, 5210.76551555181, 5219.947800521984, 5235.55497782689, 5247.658902171346, 5239.952009598077, 5271.525562699357, 5281.155015197588, 5285.2600635911, 5315.521603055705, 4993.625478089158, 5173.8189163379475, 5186.24799404088, 5191.792328306901, 5195.3246078009615, 5622.971885140589, 5653.632513886584, 5666.433356664301, 5680.602357834953, 5697.430256974311, 6081.908771368433, 6273.341299163568, 6289.748410063592, 6291.307956124822, 6293.811185664437, 6154.938450615526, 6195.969020154916, 6209.658468784215, 6272.1219029335925, 6286.4342209201395, 5806.44838740319, 5813.418658134195, 5832.154337621021, 5832.475077243069, 5871.2073870027, 6165.907511387333, 6197.318294987548, 6285.5600107992, 6288.654124023131, 6292.528060395397, 6129.603311142676, 6159.23009623797, 6159.876802463926, 6170.413810687977, 6170.969145154246, 6277.968610157011, 6278.717457714414, 6283.905741413882, 6290.779822706275, 6291.6854157291955, 5980.282366116007, 6130.054126861426, 6148.9692551536955, 6226.346233645402, 6233.501319894398, 6191.4118158774845, 6218.875622487525, 6225.501959843292, 6246.063090536365, 6258.968705156536, 4865.829695960624, 4867.683600565952, 4875.366202393666, 4883.877903052452, 4898.657094003457, 4331.047169622678, 4367.541408152162, 4439.0, 4449.466064072332, 4460.219461594208, 5738.454846789548, 5764.913526297109, 5766.711664416763, 5770.076787713946, 5821.126830975388, 6303.6532990685955, 6305.369463053658, 6306.590071645328, 6309.716062777186, 6325.304216536178, 4582.610478109398, 5603.719814009283, 5680.943190568124, 5750.02249617566, 5756.251687280626, 5346.091164502044, 5385.569154467633, 5402.270693456412, 5403.081476149064, 5407.405185429599, 6313.652749098844, 6358.205224346957, 6377.96811015942, 6378.553501254868, 6386.776462823779, 6147.84630384244, 6234.719437625408, 6276.748930042747, 6315.684215789284, 6337.144485494399, 5635.0138725723655, 6019.6990150493175, 6343.3022367538615, 6346.746130154742, 6354.968225158845, 6186.443220110212, 6194.659293738888, 6195.0, 6214.9689251553455, 6216.378362163748, 6144.8771024580155, 6187.752489900534, 6253.155823963707, 6271.4669253114, 6326.0, 4859.198232291774, 5904.261967254093, 6094.451499364901, 6112.449879510866, 6117.84705382369, 5871.853203669943, 6103.931811932983, 6106.2061931948565, 6121.602095863755, 6131.816045518642, 5895.882082358415, 5985.970070149621, 5988.520918326611, 5995.040793473024, 6015.097735339734, 6126.938730612636, 6155.322914479493, 6161.291451482957, 6166.414190651881, 6173.259208894961, 5797.246357973605, 5901.557383196192, 5995.790147344822, 6011.909821352596, 6012.939870601413], "unit": "score", "name": "dojo.html", "value": 5696.081180578359}, {"lowerIsBetter": false, "replicates": [482.0431443584482, 558.9608727389082, 587.3187102960567, 670.661316035402, 677.6886724188695, 31271.843640781794, 39048.609513904856, 39365.0, 39382.40926386107, 39459.80270098645, 42249.36625950613, 42840.71477855661, 42890.78554607223, 42909.0, 42965.570344296546, 9608.039196080406, 9845.11393974542, 9849.212063034976, 9854.556544955458, 9870.259730520203, 9596.32825702201, 9760.4631745254, 9763.511824408786, 9769.218462522982, 9775.951120244388, 9717.708468745914, 9760.975097614755, 9783.706488805312, 9784.070513301225, 9786.902130978706, 8590.0, 9855.359401638907, 9931.602735890556, 9942.154916832078, 9964.451955142464, 9676.0, 9783.706488805276, 9785.11933925943, 9819.312648114636, 9829.606815727362, 41522.1695566087, 41718.0, 41760.164796703895, 41840.16319673589, 41865.1626967462, 3060.816351018946, 3230.2570408805873, 3361.243720162968, 3373.848176832024, 3862.9183828528057, 28161.43677126446, 28896.0, 28942.42115157685, 29598.70401295981, 29693.554596681068, 2792.539231026878, 2806.410653762712, 2834.1214223590755, 2887.206018344972, 2888.364559796841, 394699.0, 395501.0, 396037.0198148991, 399048.0, 399116.0, 46100.07799843985, 54648.72675636596, 67532.3246767526, 67556.94658320516, 67621.98567021498, 45575.31637025381, 45848.770756146005, 45869.7706511472, 45979.0, 45979.54020459753, 16263.024218546925, 16461.423850165185, 16477.505674829776, 16480.587985300222, 16503.752443713354, 13143.934280328536, 13167.60497185086, 13204.60386188416, 13219.94240460761, 13234.801477977839, 14765.187914664797, 14776.965612407243, 15066.322015509328, 15098.698026039418, 15230.0, 6396.0, 6504.349565043458, 6536.8365790855605, 6552.770653027121, 6568.376004279586, 968.1770495079268, 1004.7036124343336, 1004.8894621591766, 1011.1657882247175, 1022.1414012229762, 25124.623130653054, 25310.493790124096, 29581.0, 30357.089287321414, 30434.54348184779, 1142.3260276436943, 1146.5356530605118, 1210.1347536511437, 1258.7985922252396, 1316.6642506161058, 11287.661370158909, 14540.709185816437, 15717.449889253821, 15862.682746345008, 15904.045757254602, 509436.0, 514719.8528014747, 514867.0, 515835.0, 518926.40536797076, 50082.24876626854, 59876.503087422294, 60355.69822150861, 60396.39603603996, 60420.09369859456, 1467.5670677150054, 1498.355707045959, 1544.6910617876244, 1548.5276990518, 1552.0299812617113, 28596.142115736562, 28907.132786016453, 29080.127596172148, 29473.263168420963, 29584.964526241478, 47034.82412939567, 57961.0, 59235.703821480616, 59245.70377148087, 59383.81232375242, 407357.0, 410127.0, 412820.0, 413503.0, 415011.0, 37276.06809829776, 43531.78234108936, 43613.78193109141, 44137.33793993157, 45289.773551132035, 42776.50282240107, 43216.567834322515, 43482.91292717581, 44703.0, 44772.55227447684, 32836.50745238871, 34597.48103778395, 34699.826500868345, 35483.0, 37200.81399593093, 29789.808407664317, 33534.49698254577, 36090.63909360873, 36430.0, 37055.8147209273, 38206.85379438621, 38487.0, 38518.614813852626, 38728.0, 39492.40761388524, 30918.0, 31611.84194079015, 31798.841005794824, 31960.0, 31976.36047279088, 24323.0, 24330.148444805054, 25064.624030639192, 25559.74440255648, 25610.871945640152], "unit": "score", "name": "ext.html", "value": 19443.922337099088}, {"lowerIsBetter": false, "replicates": [377.43950233902655, 384.7268439408022, 387.128959840359, 387.2468049643441, 387.6491774943676, 19750.25993761496, 20228.0, 20402.795972040276, 20758.584828303425, 20758.792412075876, 20404.387868363974, 21152.153913843467, 21199.364019079454, 21458.356249312506, 21498.0, 5824.155497452877, 6014.30835453924, 6029.1257767623665, 6034.064719968412, 6064.514838812885, 5352.892942141155, 5542.0, 5758.42415758425, 5794.6523208607405, 5804.361520232771, 5743.913841292384, 5758.712064396785, 5767.711614419283, 5785.27684039495, 5802.680852553108, 5622.606417550753, 5884.852878678024, 5886.17593536903, 5895.675737834417, 5915.319738230116, 5552.305961754781, 5608.355039170466, 5608.355039170507, 5629.296337957755, 5631.831045068655, 13481.730365392637, 13831.79252311216, 13870.514531991434, 13878.306084695825, 13887.79168312476, 2145.6888751131, 2226.6882636430914, 2385.4871202691506, 2621.7116117227088, 2863.7708983281286, 10113.595456181743, 10222.386656800616, 10556.10273126785, 11657.766844663143, 15190.924045379812, 1665.2839279109978, 1725.775649165613, 1739.391213075426, 1777.306850328373, 1878.229925730444, 78050.04874878116, 100631.0, 127264.0, 127424.0, 127609.08586371304, 8956.83561137048, 10663.200259980533, 11469.483873225725, 11521.596744113916, 11615.941920290345, 14266.785998210034, 14279.428822847178, 14323.85676143246, 14330.641733956525, 14343.282835858374, 8628.827423451496, 8795.604197811113, 8804.47173169599, 8866.157715017063, 8913.197812196933, 8916.15296546827, 8935.642574297086, 8941.642334306554, 9010.59452324647, 9016.59425325862, 4041.515018197835, 4287.399764033038, 4402.471703395613, 4471.6869819113, 4533.909321813545, 1861.6090620969749, 1894.886306821595, 1902.6289873474816, 1919.9281150159634, 1934.429343343717, 761.9657115429708, 877.6533269358567, 927.2720914082548, 1028.4806172882795, 1041.1566631028738, 19713.50716232077, 20536.07587658529, 20595.176192952113, 20646.070926808028, 20657.793422065588, 977.4428575711776, 987.5013118375318, 990.6384169777979, 1005.6731562242301, 1049.905508504223, 10595.94702026485, 11145.49845256949, 11178.832317515244, 11198.272112312674, 11207.935246151603, 606760.0, 618650.0, 637195.0, 647422.0, 651791.0, 67458.0, 91183.80856669985, 92521.0, 117481.82518174879, 128383.35808320898, 1018.383877753963, 1023.8976102389702, 1040.765827688749, 1044.4621020174616, 1048.6853943816825, 18692.158852851928, 18764.96792676416, 18974.525636859187, 19056.142473588443, 19182.242290440867, 38874.0, 43687.12625747404, 51983.48016519786, 54056.72971635117, 55340.72329638326, 71055.28944710486, 71472.21319467055, 74341.62829186035, 74531.0, 80016.19983800087, 7957.8408431832195, 7964.9203507966495, 8091.55496447701, 8228.917710822816, 8280.71017514384, 9364.344495885223, 10775.245732798629, 12604.11771176009, 13047.412866421224, 13450.0, 11213.55145794159, 11501.309921404743, 11761.47073381717, 11824.408779560816, 11920.105992050805, 10219.386836789816, 11411.942940285246, 11465.828012579652, 11633.825492617449, 11835.408229588314, 11177.161712871404, 11251.381174035507, 11564.710882228012, 11618.244814087057, 12178.75642487163, 8484.278836298738, 11100.944495277472, 11289.153313501685, 11570.305781653127, 12122.27266364021, 11305.830412543653, 12276.631701048982, 12312.81530777057, 12373.195742276723, 12450.688732781753], "unit": "score", "name": "jquery.html", "value": 9488.620190005215}, {"lowerIsBetter": false, "replicates": [1427.9000469967107, 1620.781194538737, 1655.172413793103, 1972.7336809530718, 2063.5150739576206, 8249.463784853988, 8898.866517002241, 9104.044075372081, 9120.999999999984, 9126.406783559063, 8868.866966995483, 8898.0, 9017.143371379725, 9023.72928812135, 9031.638734450615, 2227.7301937895404, 2460.987695061531, 2517.8237523373373, 2537.188099808053, 2537.3783423061377, 2539.2382285314334, 2546.8471891686468, 2547.821652484327, 2552.9489410211786, 2556.6165075238678, 2471.7775400213977, 2509.0, 2560.8463492190435, 2565.9743402565923, 2566.5636841736855, 2326.569159966625, 2339.4034521196986, 2534.1510593951048, 2552.7574880386333, 2559.795216382685, 2494.4262819551423, 2521.420073383114, 2529.3297276221815, 2531.721510633829, 2571.742825717432, 9119.49842758648, 9174.036726143726, 9187.908120918772, 9188.494632795193, 9196.080391960817, 5554.694491802949, 5719.742611582489, 5719.828405147852, 5720.427957204288, 5727.713614319267, 3649.817509124533, 3730.552333719971, 3792.639699228569, 3792.7345085844004, 3821.522309711286, 1057.7408534908996, 1073.9677809665723, 1082.86464191976, 1090.460222190021, 1106.33066994468, 10499.79000419995, 12607.991360691123, 12612.81080783789, 12634.999999999907, 12656.303903285316, 4227.365895115696, 4937.925931111036, 4992.650514463952, 5093.796248150106, 5112.667676601083, 10624.681259562225, 10628.5651437055, 10632.41521716313, 10642.467876606293, 10643.893561064446, 5775.075987841925, 5776.566757493205, 5794.0, 5798.797042103506, 5840.649561026267, 4633.49031606523, 4805.183118869731, 5001.424836143818, 5145.434002259748, 5249.737513124329, 3365.8821941232427, 4066.4103704962613, 4077.3068578341754, 4102.384642303678, 4129.958700413017, 1333.9266340351373, 1342.5099838558856, 1347.9056466047282, 1356.2337279437086, 1360.0615575253044, 1414.4130185972913, 1446.8408475067733, 1455.2432734977751, 1458.1032664911004, 1477.0694462488564, 8579.528125953133, 8633.136686331316, 8680.0, 8703.738887833248, 8706.347023973227, 458.31340666347495, 523.9947600523946, 532.6564365983919, 534.6471328922893, 535.1491129104742, 6359.936400635935, 6373.235211774524, 6426.068220108058, 6432.13166222554, 6443.581167224115, 10836.891631083747, 11354.148438867118, 11390.487428065757, 11405.144614153805, 11409.315441073562, 10769.299995500267, 11134.387608681438, 11138.554457821596, 11206.775864482664, 11253.381064041556, 8626.741197764077, 8747.300215982834, 8790.472571645594, 8801.867971980426, 8831.823363532694, 8201.79495512617, 8216.835663286582, 8306.501609903426, 8327.583620819056, 8332.041815191089, 9732.41605503672, 10025.947275536255, 10100.242481813746, 10152.289339746147, 10173.28786984904, 9741.659041933499, 10069.043440873398, 10100.191984641358, 10116.19070474375, 10461.738456538647, 7710.92289077102, 8132.959335203286, 8464.322854171774, 8473.49159050459, 8481.618327175169, 7219.314165154302, 8569.228769410784, 8632.223099921037, 8632.784180395289, 8657.696980605648, 7408.222136675571, 7498.0, 7564.281393267631, 7597.0, 7642.5032372895585, 7299.5620262784405, 7378.483506154733, 7454.142773581108, 7572.091349038151, 7579.621018949141, 6895.275996020346, 8024.919750802417, 8104.797380065545, 8107.959460202661, 8125.268725814705, 6964.233934267328, 7176.928230717626, 7227.9638601806655, 7264.673089711081, 7266.818329541592, 7313.670884810303, 7340.0, 7354.264573542603, 7379.963100184465, 7381.298776616213], "unit": "score", "name": "mootools.html", "value": 5025.552865987752}, {"lowerIsBetter": false, "replicates": [302.50691373061903, 319.25931838135523, 331.9883804066858, 336.27700444045314, 339.83348159401885, 6650.9667451662735, 6666.433353164987, 6715.2277488088885, 6719.294474080224, 6728.0, 6579.473642108632, 6579.506537009719, 6588.407043366096, 6611.504137189718, 6631.336866313366, 3629.909252268688, 3898.654964037417, 4659.6505262105475, 4892.363992680965, 4924.458309585952, 4862.854114376574, 4876.366072410599, 4890.193118135503, 4896.436909755388, 4916.606671466274, 4799.088173247089, 4813.90372192556, 4820.252860806563, 4840.854774356775, 4859.052484765472, 4608.193566125931, 4724.409448818915, 4825.0, 4832.758362081881, 4844.951550484485, 4123.752574845519, 4125.91748165038, 4138.91722165558, 4140.0, 4148.605882441163, 5162.45794191612, 6293.968530157365, 6300.779472718478, 6364.172657554534, 6392.4246817786625, 4759.524547390285, 5804.100364443518, 5809.82570522885, 5823.359430462646, 5835.183074369592, 6360.141380913564, 6776.322367763233, 7047.718091276342, 7068.010478532958, 7071.504994650377, 4364.301711726141, 4537.795799189044, 4562.954370456286, 4569.794359253809, 4571.0, 6385.457236134934, 7319.59742214178, 7473.663685134182, 7491.25087491252, 7491.475596708178, 4635.327877457749, 4636.86089417318, 4639.791209395517, 4650.395448591661, 4651.441826980784, 4019.1559772448113, 4691.249400096037, 4710.646701497401, 4719.787609557578, 4721.858344249678, 5597.244372009808, 5612.186232996192, 5614.606977511617, 5633.746481408347, 5636.323641163087, 6810.523263371616, 7056.329648683367, 7063.869780835042, 7065.89401158983, 7100.60946647929, 1609.4286528282291, 1614.2413065859027, 1630.193054438037, 1632.6734653069434, 1632.71427500187, 979.9167070799062, 1006.3861044762689, 1023.0792286941812, 1028.9125424338865, 1050.847627094067, 6580.901286480706, 6711.731530738716, 6742.898856517156, 6759.0, 6779.35596118368, 5670.8036053321075, 6326.841828954221, 7166.0, 7388.7044518219745, 7397.8150546236775, 6739.528233023641, 6773.119494465688, 6774.559653622498, 6776.288489708608, 6791.830204244933, 3861.8455261789777, 3893.2018936118593, 3902.8829135125993, 3907.081835768592, 3908.6286802753693, 6705.362990515893, 6948.374646281859, 6999.600079984024, 7708.653110610036, 7709.575973321521, 7499.2500749924575, 7574.431917606202, 7577.469577129658, 7665.655045522964, 7666.501677391063, 7747.72882949094, 7765.0, 7775.844483110306, 7782.49413788102, 7794.766157015299, 7146.857062858609, 7278.490505664553, 7384.704611815468, 7390.482666213314, 7410.6665200065045, 7219.639018049182, 7263.6005019724425, 7291.0, 7296.233895440902, 7302.853942921218, 7749.883751743616, 7751.8837217442915, 7763.61181940912, 7770.650320735694, 7775.261350171724, 4616.930746038879, 4632.5135860734135, 4647.604953578983, 4658.347831303552, 4658.487566367629, 7069.469789765891, 7347.485676002629, 7355.411567074728, 7360.300771426706, 7362.558246505227, 7068.893966590403, 7099.858002840017, 7116.501844871016, 7122.5726456412785, 7123.536970096927, 7086.255943125898, 7089.893651595334, 7094.716211351488, 7096.432285417051, 7102.715891364288, 6894.689738961659, 6894.689738961659, 6894.8621027580175, 6897.275786042594, 6913.343232392915, 6830.863382732218, 7086.822829429306, 7102.786916392516, 7105.32499412555, 7114.928850711427, 6595.967020164869, 6699.162604674416, 6774.0, 6918.515703900679, 6973.5118541701595], "unit": "score", "name": "prototype.html", "value": 5133.45803815271}, {"lowerIsBetter": false, "replicates": [684.6953105867891, 715.9606221657809, 775.5501808950809, 779.9844003119935, 790.3913986230602, 15075.170865602387, 15417.614559636, 15440.69118617627, 15456.459023934165, 15526.922365388158, 13801.861981380183, 13871.861281387182, 13878.722425551483, 13897.444102235899, 13921.02552821303, 790.5651891459703, 797.8165022044933, 941.1811723800304, 954.4893481987156, 978.4178413843787, 952.1811242331589, 962.523550842334, 966.9033096690345, 968.0561452583745, 969.1955676788284, 1040.2926010313022, 1047.005344922323, 1047.5495536919123, 1047.9004494573041, 1049.0139269087033, 842.7640260727006, 996.6013594562161, 1027.8972102789735, 1029.3875144289136, 1032.0814475117152, 766.5745511241258, 767.0833354141803, 767.5394763142126, 767.6967597798894, 768.6195333310047, 14884.776728349083, 14951.102933824006, 14965.925170374187, 14980.176090315028, 15035.54893353201, 12749.53380361261, 13259.0, 13414.195148291035, 13542.45830166802, 13554.322283885866, 9828.0, 11172.217944743872, 11200.439978001068, 11508.482118304697, 11666.766664666744, 2909.7963142579815, 3537.0980399998093, 3575.535180426528, 3607.260511595117, 3781.092537790938, 84316.73524897131, 84332.57833710792, 84601.73097403544, 84909.57545212297, 89044.0, 9248.583813728399, 9330.066993300616, 9559.569819358145, 9594.568244429018, 10094.394336339843, 17999.460016199537, 21947.67078493824, 21963.791991440303, 22006.0, 22017.449563760714, 6245.906311405332, 7546.434017448713, 7650.464467487333, 7739.690412383554, 8033.718819841278, 4050.25070361984, 4151.97924010378, 4167.041580436517, 4234.640055595309, 4396.60430561251, 3732.850685972585, 3784.413415920537, 3800.3919372900205, 3812.7140464465274, 3814.5422549294262, 565.1550931357565, 581.2385774635242, 659.1760299625469, 671.7010930136042, 696.216756149332, 548.62419242818, 576.2278546747295, 597.3309892919957, 618.3816183816184, 631.643121636274, 7063.57618542889, 8278.586070696441, 8493.320534357237, 8494.787630309293, 8651.78370540729, 527.8574784808158, 554.5314209492972, 591.2284468768213, 603.6167033933484, 622.2035794183453, 3818.694504439694, 3933.645971862546, 3985.222881538072, 3988.8603898863403, 4041.9288888444585, 90577.0, 91052.5447372759, 91434.08565914255, 91747.62378564327, 91832.0, 79257.20742792613, 79435.41129177384, 79856.80214796783, 80859.0, 81263.5936820324, 73135.63432182911, 73369.26630733837, 74774.38289659836, 75925.24074759292, 78195.60902195566, 7880.487768295043, 7989.520628762293, 8147.348212142896, 8157.75526734199, 8304.501729896225, 49395.75302123466, 49935.25097123473, 51805.0, 51974.96050079053, 52090.47909520856, 66107.0, 69581.0, 71885.6405717989, 72597.63701181671, 73912.0, 10244.02681745233, 10350.948245258725, 11163.162762792661, 11436.199466037298, 11754.76490470203, 11978.221415607957, 12028.398580071136, 12099.81850272229, 12180.512779488721, 13211.471541138248, 11344.262622929813, 11494.0, 11581.536738530365, 11612.303261804318, 11659.76680466369, 11334.263272887236, 11560.94219528897, 11623.6512904613, 11846.0, 12214.267143971034, 11393.601223957121, 11492.770144597229, 11699.064074873819, 11731.88268117308, 12075.75848483043, 9517.670857958805, 9549.570269338035, 9702.078302561245, 9993.250506212209, 10087.344322619007, 9094.545272736468, 9633.807323853343, 9847.212223021997, 9889.25830562725, 9896.059874311928], "unit": "score", "name": "yui.html", "value": 7079.361502175523}], "name": "dromaeo_css", "value": 7595.052502602512}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 110.0, 110.0, 112.0, 113.0, 120.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [155.0, 123.0, 151.0, 149.0, 117.0, 140.0, 118.0, 153.0, 146.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 136.9}, {"lowerIsBetter": true, "replicates": [185.0, 185.0, 186.0, 183.0, 188.0, 185.0, 183.0, 186.0, 184.0, 187.0], "unit": "score", "name": "audio-dft", "value": 185.2}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 76.0, 117.0, 56.0, 57.0, 57.0, 58.0, 114.0, 57.0], "unit": "score", "name": "audio-fft", "value": 73.7}, {"lowerIsBetter": true, "replicates": [91.0, 95.0, 129.0, 79.0, 80.0, 89.0, 105.0, 78.0, 106.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 99.7}, {"lowerIsBetter": true, "replicates": [87.0, 83.0, 88.0, 84.0, 86.0, 85.0, 88.0, 124.0, 81.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.0}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 92.0, 93.0, 92.0, 104.0, 150.0, 92.0, 92.0, 91.0], "unit": "score", "name": "imaging-darkroom", "value": 99.0}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 87.0, 83.0, 86.0, 85.0, 87.0, 101.0, 141.0, 117.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 57.0, 57.0, 58.0, 58.0, 57.0, 68.0, 54.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [63.0, 61.0, 69.0, 79.0, 69.0, 68.0, 66.0, 67.0, 67.0, 72.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [81.0, 95.0, 109.0, 105.0, 100.0, 80.0, 80.0, 80.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.6}, {"lowerIsBetter": true, "replicates": [119.0, 120.0, 118.0, 117.0, 118.0, 119.0, 120.0, 135.0, 130.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.8}, {"lowerIsBetter": true, "replicates": [136.0, 124.0, 132.0, 132.0, 136.0, 122.0, 133.0, 130.0, 135.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 131.2}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 70.0, 82.0, 92.0, 63.0, 54.0, 87.0, 90.0, 91.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 76.1}], "name": "kraken", "value": 1439.0}]} 16:36:04 INFO - Return code: 0 16:36:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:36:04 INFO - # TBPL SUCCESS # 16:36:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:36:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:36:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:36:04 INFO - 2016-04-05 16:36:04.436 screenresolution[1679:10176] starting screenresolution argv=screenresolution get 16:36:04 INFO - 2016-04-05 16:36:04.439 screenresolution[1679:10176] Display 0: 1600x1200x32@60 16:36:04 INFO - 2016-04-05 16:36:04.444 screenresolution[1680:10179] starting screenresolution argv=screenresolution list 16:36:04 INFO - Available Modes on Display 0 16:36:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:36:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:36:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:36:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:36:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:36:04 INFO - Intel Iris: 16:36:04 INFO - Chipset Model: Intel Iris 16:36:04 INFO - Type: GPU 16:36:04 INFO - Bus: Built-In 16:36:04 INFO - VRAM (Dynamic, Max): 1536 MB 16:36:04 INFO - Vendor: Intel (0x8086) 16:36:04 INFO - Device ID: 0x0a2e 16:36:04 INFO - Revision ID: 0x0009 16:36:04 INFO - Displays: 16:36:04 INFO - Display: 16:36:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:36:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:36:04 INFO - Display Serial Number: 1600x1200 60 16:36:04 INFO - Main Display: Yes 16:36:04 INFO - Mirror: Off 16:36:04 INFO - Online: Yes 16:36:04 INFO - Rotation: Supported 16:36:04 INFO - Return code: 0 16:36:04 INFO - Running post-action listener: _resource_record_post_action 16:36:04 INFO - Running post-run listener: _resource_record_post_run 16:36:05 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 37897728; Write bytes: 666427904; Read time: 399; Write time: 1907 16:36:05 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 352682496; Write bytes: 354059776; Read time: 27673; Write time: 681 16:36:05 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 36943360; Write bytes: 302029824; Read time: 385; Write time: 1193 16:36:05 INFO - Running post-run listener: _upload_blobber_files 16:36:05 INFO - Blob upload gear active. 16:36:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:36:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:36:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:36:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:36:06 INFO - (blobuploader) - INFO - Open directory for files ... 16:36:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:36:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:36:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:36:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:36:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:36:06 INFO - (blobuploader) - INFO - Done attempting. 16:36:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:36:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:36:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:36:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:36:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:36:07 INFO - (blobuploader) - INFO - Done attempting. 16:36:07 INFO - (blobuploader) - INFO - Iteration through files over. 16:36:07 INFO - Return code: 0 16:36:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:36:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:36:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80156f1664b6a38255a4766d35c9b50019985af7526b867a8ecdbdc1c991dfc70688dfa93f588273be314a73b288af59aad2ced1f9189a47d7e4cd0aa4644758", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f971919d83cba284685f62f41c3e49a43556457cbd1bb6e634442ba4954cedca351e3f6a1767c600d8e0bee25928a04b6f421eb7c5c4e21cfecf9bb975aac7f6"} 16:36:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:36:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:36:07 INFO - Contents: 16:36:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80156f1664b6a38255a4766d35c9b50019985af7526b867a8ecdbdc1c991dfc70688dfa93f588273be314a73b288af59aad2ced1f9189a47d7e4cd0aa4644758", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f971919d83cba284685f62f41c3e49a43556457cbd1bb6e634442ba4954cedca351e3f6a1767c600d8e0bee25928a04b6f421eb7c5c4e21cfecf9bb975aac7f6"} 16:36:07 INFO - Running post-run listener: copy_logs_to_upload_dir 16:36:07 INFO - Copying logs to upload dir... 16:36:07 INFO - mkdir: /builds/slave/test/build/upload/logs 16:36:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.440602 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-05 16:36:07.924506) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 16:36:07.928401) ========= 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.P11fffXo2d/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.zo640JgX4B/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80156f1664b6a38255a4766d35c9b50019985af7526b867a8ecdbdc1c991dfc70688dfa93f588273be314a73b288af59aad2ced1f9189a47d7e4cd0aa4644758", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f971919d83cba284685f62f41c3e49a43556457cbd1bb6e634442ba4954cedca351e3f6a1767c600d8e0bee25928a04b6f421eb7c5c4e21cfecf9bb975aac7f6"} build_url:https://queue.taskcluster.net/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010893 build_url: 'https://queue.taskcluster.net/v1/task/C7vQ--u2S7iTtsloEQw9Sw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80156f1664b6a38255a4766d35c9b50019985af7526b867a8ecdbdc1c991dfc70688dfa93f588273be314a73b288af59aad2ced1f9189a47d7e4cd0aa4644758", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f971919d83cba284685f62f41c3e49a43556457cbd1bb6e634442ba4954cedca351e3f6a1767c600d8e0bee25928a04b6f421eb7c5c4e21cfecf9bb975aac7f6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 16:36:07.956028) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 16:36:07.956466) ========= 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.P11fffXo2d/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.zo640JgX4B/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.004921 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 16:36:08.006225) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 16:36:08.006583) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 16:36:08.007057) ========= ========= Total master_lag: 0.26 =========