builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0089 starttime: 1458325448.81 results: success (0) buildid: 20160318090116 builduid: e0caf48356c444659f1f94c22c55b7b1 revision: 854a8a7e9606c5e5dc0eaa6a67cd52b19d58f51f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 11:24:08.808251) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 11:24:08.808623) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 11:24:08.810920) ========= 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.7AKQu0qvoP/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.FdG1EuSS5D/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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.005471 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 11:24:08.847487) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-03-18 11:24:08.851802) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-03-18 11:24:10.063159) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:24:10.063640) ========= 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.7AKQu0qvoP/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.FdG1EuSS5D/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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.005738 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:24:10.120008) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 11:24:10.120320) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 11:24:10.120670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:24:10.120957) ========= 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.7AKQu0qvoP/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.FdG1EuSS5D/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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-03-18 11:24:10-- 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% 33.1M=0s 2016-03-18 11:24:10 (33.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.467827 ========= master_lag: 0.38 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:24:10.969871) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:24:10.970291) ========= 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.7AKQu0qvoP/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.FdG1EuSS5D/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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.030427 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:24:11.028171) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:24:11.028519) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 854a8a7e9606c5e5dc0eaa6a67cd52b19d58f51f --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 854a8a7e9606c5e5dc0eaa6a67cd52b19d58f51f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7AKQu0qvoP/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.FdG1EuSS5D/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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-03-18 11:24:11,106 truncating revision to first 12 chars 2016-03-18 11:24:11,106 Setting DEBUG logging. 2016-03-18 11:24:11,106 attempt 1/10 2016-03-18 11:24:11,106 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/854a8a7e9606?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-18 11:24:11,721 unpacking tar archive at: mozilla-aurora-854a8a7e9606/testing/mozharness/ program finished with exit code 0 elapsedTime=0.879729 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:24:11.929135) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 11:24:11.929527) ========= echo 854a8a7e9606c5e5dc0eaa6a67cd52b19d58f51f in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'854a8a7e9606c5e5dc0eaa6a67cd52b19d58f51f'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7AKQu0qvoP/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.FdG1EuSS5D/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 854a8a7e9606c5e5dc0eaa6a67cd52b19d58f51f program finished with exit code 0 elapsedTime=0.006074 script_repo_revision: '854a8a7e9606c5e5dc0eaa6a67cd52b19d58f51f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 11:24:11.982432) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 11:24:11.982736) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 11:24:12.010323) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-03-18 11:24:12.010706) ========= /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.7AKQu0qvoP/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.FdG1EuSS5D/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 11:24:12 INFO - MultiFileLogger online at 20160318 11:24:12 in /builds/slave/test 11:24:12 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 11:24:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:24:12 INFO - {'append_to_log': False, 11:24:12 INFO - 'base_work_dir': '/builds/slave/test', 11:24:12 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:24:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:24:12 INFO - 'branch': 'Mozilla-Aurora', 11:24:12 INFO - 'buildbot_json_path': 'buildprops.json', 11:24:12 INFO - 'config_files': ('talos/mac_config.py',), 11:24:12 INFO - 'default_actions': ('clobber', 11:24:12 INFO - 'read-buildbot-config', 11:24:12 INFO - 'download-and-extract', 11:24:12 INFO - 'populate-webroot', 11:24:12 INFO - 'create-virtualenv', 11:24:12 INFO - 'install', 11:24:12 INFO - 'run-tests'), 11:24:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:24:12 INFO - 'download_minidump_stackwalk': True, 11:24:12 INFO - 'download_symbols': 'ondemand', 11:24:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:24:12 INFO - 'tooltool.py': '/tools/tooltool.py', 11:24:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:24:12 INFO - '/tools/misc-python/virtualenv.py')}, 11:24:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:24:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:24:12 INFO - 'installer_path': 'installer.exe', 11:24:12 INFO - 'log_level': 'info', 11:24:12 INFO - 'log_name': 'talos', 11:24:12 INFO - 'log_to_console': True, 11:24:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:24:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:24:12 INFO - 'opt_config_files': (), 11:24:12 INFO - 'pip_index': False, 11:24:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:24:12 INFO - 'cmd': ('bash', 11:24:12 INFO - '-c', 11:24:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:24:12 INFO - 'enabled': True, 11:24:12 INFO - 'halt_on_failure': False, 11:24:12 INFO - 'name': 'check_screen_resolution'},), 11:24:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:24:12 INFO - 'cmd': ('bash', 11:24:12 INFO - '-c', 11:24:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:24:12 INFO - 'enabled': True, 11:24:12 INFO - 'halt_on_failure': False, 11:24:12 INFO - 'name': 'check_screen_resolution'},), 11:24:12 INFO - 'run_cmd_checks_enabled': True, 11:24:12 INFO - 'sps_profile': False, 11:24:12 INFO - 'sps_profile_interval': 0, 11:24:12 INFO - 'suite': 'dromaeojs', 11:24:12 INFO - 'system_bits': '32', 11:24:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:24:12 INFO - 'title': 't-yosemite-r7-0089', 11:24:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:24:12 INFO - 'use_talos_json': True, 11:24:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:24:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:24:12 INFO - 'work_dir': 'build'} 11:24:12 INFO - ##### 11:24:12 INFO - ##### Running clobber step. 11:24:12 INFO - ##### 11:24:12 INFO - Running pre-action listener: _resource_record_pre_action 11:24:12 INFO - Running main action method: clobber 11:24:12 INFO - rmtree: /builds/slave/test/build 11:24:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:24:13 INFO - Running post-action listener: _resource_record_post_action 11:24:13 INFO - ##### 11:24:13 INFO - ##### Running read-buildbot-config step. 11:24:13 INFO - ##### 11:24:13 INFO - Running pre-action listener: _resource_record_pre_action 11:24:13 INFO - Running main action method: read_buildbot_config 11:24:13 INFO - Using buildbot properties: 11:24:13 INFO - { 11:24:13 INFO - "project": "", 11:24:13 INFO - "product": "firefox", 11:24:13 INFO - "script_repo_revision": "production", 11:24:13 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 11:24:13 INFO - "repository": "", 11:24:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 11:24:13 INFO - "buildid": "20160318090116", 11:24:13 INFO - "pgo_build": "False", 11:24:13 INFO - "basedir": "/builds/slave/test", 11:24:13 INFO - "buildnumber": 238, 11:24:13 INFO - "slavename": "t-yosemite-r7-0089", 11:24:13 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 11:24:13 INFO - "platform": "yosemite_r7", 11:24:13 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 11:24:13 INFO - "branch": "mozilla-aurora", 11:24:13 INFO - "repo_path": "releases/mozilla-aurora", 11:24:13 INFO - "revision": "854a8a7e9606c5e5dc0eaa6a67cd52b19d58f51f", 11:24:13 INFO - "stage_platform": "macosx64", 11:24:13 INFO - "builduid": "e0caf48356c444659f1f94c22c55b7b1", 11:24:13 INFO - "slavebuilddir": "test" 11:24:13 INFO - } 11:24:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/P5cezEc_TfuG9sa4gmb0zg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 11:24:13 INFO - Running post-action listener: _resource_record_post_action 11:24:13 INFO - ##### 11:24:13 INFO - ##### Running download-and-extract step. 11:24:13 INFO - ##### 11:24:13 INFO - Running pre-action listener: _resource_record_pre_action 11:24:13 INFO - Running main action method: download_and_extract 11:24:13 INFO - mkdir: /builds/slave/test/build/tests 11:24:13 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')]} 11:24:13 INFO - https://queue.taskcluster.net/v1/task/P5cezEc_TfuG9sa4gmb0zg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:24:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5cezEc_TfuG9sa4gmb0zg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 11:24:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5cezEc_TfuG9sa4gmb0zg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 11:24:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5cezEc_TfuG9sa4gmb0zg/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 11:24:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5cezEc_TfuG9sa4gmb0zg/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 11:24:15 INFO - Downloaded 1277 bytes. 11:24:15 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 11:24:15 INFO - Using the following test package requirements: 11:24:15 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 11:24:15 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:24:15 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 11:24:15 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:24:15 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 11:24:15 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:24:15 INFO - u'jsshell-mac.zip'], 11:24:15 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:24:15 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 11:24:15 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 11:24:15 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:24:15 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 11:24:15 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:24:15 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 11:24:15 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:24:15 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 11:24:15 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 11:24:15 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:24:15 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 11:24:15 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 11:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:15 INFO - https://queue.taskcluster.net/v1/task/P5cezEc_TfuG9sa4gmb0zg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:24:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5cezEc_TfuG9sa4gmb0zg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 11:24:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5cezEc_TfuG9sa4gmb0zg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 11:24:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5cezEc_TfuG9sa4gmb0zg/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 11:24:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5cezEc_TfuG9sa4gmb0zg/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 11:24:16 INFO - Downloaded 17867931 bytes. 11:24: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'] 11:24: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 11:24:19 INFO - Return code: 0 11:24:19 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 11:24: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')]} 11:24:19 INFO - https://queue.taskcluster.net/v1/task/P5cezEc_TfuG9sa4gmb0zg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:24:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5cezEc_TfuG9sa4gmb0zg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 11:24:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5cezEc_TfuG9sa4gmb0zg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 11:24:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5cezEc_TfuG9sa4gmb0zg/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 11:24:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5cezEc_TfuG9sa4gmb0zg/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 11:24:24 INFO - Downloaded 17867931 bytes. 11:24:24 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'] 11:24:24 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 11:24:28 INFO - Return code: 0 11:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:28 INFO - https://queue.taskcluster.net/v1/task/P5cezEc_TfuG9sa4gmb0zg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:24:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5cezEc_TfuG9sa4gmb0zg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 11:24:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5cezEc_TfuG9sa4gmb0zg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 11:24:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5cezEc_TfuG9sa4gmb0zg/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 11:24:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5cezEc_TfuG9sa4gmb0zg/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 11:24:30 INFO - Downloaded 10845161 bytes. 11:24:30 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'] 11:24:30 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 11:24:30 INFO - Return code: 0 11:24:30 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')]} 11:24:30 INFO - https://queue.taskcluster.net/v1/task/P5cezEc_TfuG9sa4gmb0zg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 11:24:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5cezEc_TfuG9sa4gmb0zg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 11:24:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5cezEc_TfuG9sa4gmb0zg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 11:24:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5cezEc_TfuG9sa4gmb0zg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 11:24:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5cezEc_TfuG9sa4gmb0zg/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 11:24:34 INFO - Downloaded 114987102 bytes. 11:24:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P5cezEc_TfuG9sa4gmb0zg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 11:24:34 INFO - mkdir: /builds/slave/test/properties 11:24:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:24:34 INFO - Writing to file /builds/slave/test/properties/build_url 11:24:34 INFO - Contents: 11:24:34 INFO - build_url:https://queue.taskcluster.net/v1/task/P5cezEc_TfuG9sa4gmb0zg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 11:24:35 INFO - Running post-action listener: _resource_record_post_action 11:24:35 INFO - Running post-action listener: set_extra_try_arguments 11:24:35 INFO - ##### 11:24:35 INFO - ##### Running populate-webroot step. 11:24:35 INFO - ##### 11:24:35 INFO - Running pre-action listener: _resource_record_pre_action 11:24:35 INFO - Running main action method: populate_webroot 11:24:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:24:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:24:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:24:35 INFO - '--tppagecycles', 11:24:35 INFO - '7'], 11:24:35 INFO - 'tests': ['tsvgm']}}, 11:24:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:24:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:24:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:24:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:24:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:24:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:24:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:35 INFO - 'talos_options': ['--e10s'], 11:24:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:35 INFO - 'tests': ['damp', 'tps']}, 11:24:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:35 INFO - 'talos_options': ['--e10s'], 11:24:35 INFO - 'tests': ['damp', 'tps']}, 11:24:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:24:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:24:35 INFO - 'other': {'tests': ['a11yr', 11:24:35 INFO - 'ts_paint', 11:24:35 INFO - 'tpaint', 11:24:35 INFO - 'sessionrestore', 11:24:35 INFO - 'sessionrestore_no_auto_restore', 11:24:35 INFO - 'tabpaint']}, 11:24:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:24:35 INFO - 'tests': ['a11yr', 11:24:35 INFO - 'ts_paint', 11:24:35 INFO - 'tpaint', 11:24:35 INFO - 'sessionrestore', 11:24:35 INFO - 'sessionrestore_no_auto_restore', 11:24:35 INFO - 'tabpaint']}, 11:24:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:24:35 INFO - 'tests': ['a11yr', 11:24:35 INFO - 'ts_paint', 11:24:35 INFO - 'tpaint', 11:24:35 INFO - 'sessionrestore', 11:24:35 INFO - 'sessionrestore_no_auto_restore', 11:24:35 INFO - 'tabpaint']}, 11:24:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:24:35 INFO - 'tests': ['a11yr', 11:24:35 INFO - 'ts_paint', 11:24:35 INFO - 'tpaint', 11:24:35 INFO - 'sessionrestore', 11:24:35 INFO - 'sessionrestore_no_auto_restore', 11:24:35 INFO - 'tabpaint']}, 11:24:35 INFO - 'other_l64': {'tests': ['a11yr', 11:24:35 INFO - 'ts_paint', 11:24:35 INFO - 'tpaint', 11:24:35 INFO - 'sessionrestore', 11:24:35 INFO - 'sessionrestore_no_auto_restore', 11:24:35 INFO - 'tabpaint']}, 11:24:35 INFO - 'other_nol64': {'tests': ['a11yr', 11:24:35 INFO - 'ts_paint', 11:24:35 INFO - 'tpaint', 11:24:35 INFO - 'sessionrestore', 11:24:35 INFO - 'sessionrestore_no_auto_restore', 11:24:35 INFO - 'tabpaint']}, 11:24:35 INFO - 'svgr': {'tests': ['tsvgx', 11:24:35 INFO - 'tsvgr_opacity', 11:24:35 INFO - 'tart', 11:24:35 INFO - 'tscrollx', 11:24:35 INFO - 'cart']}, 11:24:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:24:35 INFO - 'tests': ['tsvgx', 11:24:35 INFO - 'tsvgr_opacity', 11:24:35 INFO - 'tart', 11:24:35 INFO - 'tscrollx', 11:24:35 INFO - 'cart']}, 11:24:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:35 INFO - 'tests': ['tp5o']}, 11:24:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:35 INFO - 'talos_options': ['--e10s'], 11:24:35 INFO - 'tests': ['tp5o']}, 11:24:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:35 INFO - 'talos_options': ['--xperf_path', 11:24:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:35 INFO - 'tests': ['tp5n']}, 11:24:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:35 INFO - 'talos_options': ['--e10s', 11:24:35 INFO - '--xperf_path', 11:24:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:35 INFO - 'tests': ['tp5n']}}, 11:24:35 INFO - 'talos.zip': {'path': '', 11:24:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:24:35 INFO - Running post-action listener: _resource_record_post_action 11:24:35 INFO - ##### 11:24:35 INFO - ##### Running create-virtualenv step. 11:24:35 INFO - ##### 11:24:35 INFO - Running pre-action listener: _resource_record_pre_action 11:24:35 INFO - Running main action method: create_virtualenv 11:24:35 INFO - Creating virtualenv /builds/slave/test/build/venv 11:24:35 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 11:24:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:24:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:24:35 INFO - Using real prefix '/tools/python27' 11:24:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:24:36 INFO - Installing distribute.............................................................................................................................................................................................done. 11:24:39 INFO - Installing pip.................done. 11:24:39 INFO - Return code: 0 11:24:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:39 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 0x10178aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017914c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf30d819d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10162ed30>, '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 0x101492db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101625b20>, '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.7AKQu0qvoP/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.FdG1EuSS5D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 11:24:39 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 11:24:39 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 11:24:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7AKQu0qvoP/Render', 11:24:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:39 INFO - 'HOME': '/Users/cltbld', 11:24:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:39 INFO - 'LOGNAME': 'cltbld', 11:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:39 INFO - 'MOZ_NO_REMOTE': '1', 11:24:39 INFO - 'NO_EM_RESTART': '1', 11:24:39 INFO - 'PAGER': '/bin/cat', 11:24:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:39 INFO - 'PWD': '/builds/slave/test', 11:24:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:39 INFO - 'SHELL': '/bin/bash', 11:24:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdG1EuSS5D/Listeners', 11:24:39 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 11:24:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:39 INFO - 'USER': 'cltbld', 11:24:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:39 INFO - 'XPC_FLAGS': '0x0', 11:24:39 INFO - 'XPC_SERVICE_NAME': '0', 11:24:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:39 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 11:24:39 INFO - Cleaning up... 11:24:39 INFO - Return code: 0 11:24:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:39 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 0x10178aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017914c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf30d819d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10162ed30>, '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 0x101492db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101625b20>, '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.7AKQu0qvoP/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.FdG1EuSS5D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 11:24:39 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 11:24:39 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 11:24:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7AKQu0qvoP/Render', 11:24:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:39 INFO - 'HOME': '/Users/cltbld', 11:24:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:39 INFO - 'LOGNAME': 'cltbld', 11:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:39 INFO - 'MOZ_NO_REMOTE': '1', 11:24:39 INFO - 'NO_EM_RESTART': '1', 11:24:39 INFO - 'PAGER': '/bin/cat', 11:24:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:39 INFO - 'PWD': '/builds/slave/test', 11:24:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:39 INFO - 'SHELL': '/bin/bash', 11:24:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdG1EuSS5D/Listeners', 11:24:39 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 11:24:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:39 INFO - 'USER': 'cltbld', 11:24:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:39 INFO - 'XPC_FLAGS': '0x0', 11:24:39 INFO - 'XPC_SERVICE_NAME': '0', 11:24:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:39 INFO - Downloading/unpacking psutil>=0.7.1 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:24:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:43 INFO - Installing collected packages: psutil 11:24:43 INFO - Running setup.py install for psutil 11:24:43 INFO - building 'psutil._psutil_osx' extension 11:24:43 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 11:24:43 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 11:24:43 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 11:24:44 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 11:24:44 INFO - building 'psutil._psutil_posix' extension 11:24:44 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 11:24:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:24:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:24:44 INFO - ^ 11:24:44 INFO - 1 warning generated. 11:24:44 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 11:24:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:44 INFO - Successfully installed psutil 11:24:44 INFO - Cleaning up... 11:24:44 INFO - Return code: 0 11:24:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:24:44 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')]} 11:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:44 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')]} 11:24:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:44 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 0x10178aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017914c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf30d819d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10162ed30>, '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 0x101492db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101625b20>, '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.7AKQu0qvoP/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.FdG1EuSS5D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 11:24:44 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 11:24:44 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 11:24:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7AKQu0qvoP/Render', 11:24:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:44 INFO - 'HOME': '/Users/cltbld', 11:24:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:44 INFO - 'LOGNAME': 'cltbld', 11:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:44 INFO - 'MOZ_NO_REMOTE': '1', 11:24:44 INFO - 'NO_EM_RESTART': '1', 11:24:44 INFO - 'PAGER': '/bin/cat', 11:24:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:44 INFO - 'PWD': '/builds/slave/test', 11:24:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:44 INFO - 'SHELL': '/bin/bash', 11:24:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdG1EuSS5D/Listeners', 11:24:44 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 11:24:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:44 INFO - 'USER': 'cltbld', 11:24:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:44 INFO - 'XPC_FLAGS': '0x0', 11:24:44 INFO - 'XPC_SERVICE_NAME': '0', 11:24:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:24:44 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 11:24:44 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 11:24:44 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 11:24:44 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 11:24:44 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 11:24:44 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 11:24:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:24:47 INFO - Installing collected packages: mozsystemmonitor 11:24:47 INFO - Running setup.py install for mozsystemmonitor 11:24:47 INFO - Successfully installed mozsystemmonitor 11:24:47 INFO - Cleaning up... 11:24:47 INFO - Return code: 0 11:24:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:47 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 0x10178aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017914c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf30d819d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10162ed30>, '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 0x101492db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101625b20>, '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.7AKQu0qvoP/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.FdG1EuSS5D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 11:24:47 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 11:24:47 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 11:24:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7AKQu0qvoP/Render', 11:24:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:47 INFO - 'HOME': '/Users/cltbld', 11:24:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:47 INFO - 'LOGNAME': 'cltbld', 11:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:47 INFO - 'MOZ_NO_REMOTE': '1', 11:24:47 INFO - 'NO_EM_RESTART': '1', 11:24:47 INFO - 'PAGER': '/bin/cat', 11:24:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:47 INFO - 'PWD': '/builds/slave/test', 11:24:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:47 INFO - 'SHELL': '/bin/bash', 11:24:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdG1EuSS5D/Listeners', 11:24:47 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 11:24:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:47 INFO - 'USER': 'cltbld', 11:24:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:47 INFO - 'XPC_FLAGS': '0x0', 11:24:47 INFO - 'XPC_SERVICE_NAME': '0', 11:24:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:47 INFO - Downloading/unpacking blobuploader==1.2.4 11:24:47 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 11:24:47 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 11:24:47 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 11:24:47 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 11:24:47 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 11:24:47 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 11:24:49 INFO - Downloading blobuploader-1.2.4.tar.gz 11:24:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:24:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:24:50 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 11:24:50 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 11:24:50 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 11:24:50 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 11:24:50 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 11:24:50 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 11:24:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:24:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:24:50 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 11:24:50 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 11:24:50 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 11:24:50 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 11:24:50 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 11:24:50 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 11:24:51 INFO - Downloading docopt-0.6.1.tar.gz 11:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:24:51 INFO - Installing collected packages: blobuploader, requests, docopt 11:24:51 INFO - Running setup.py install for blobuploader 11:24:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:24:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:24:51 INFO - Running setup.py install for requests 11:24:51 INFO - Running setup.py install for docopt 11:24:51 INFO - Successfully installed blobuploader requests docopt 11:24:51 INFO - Cleaning up... 11:24:52 INFO - Return code: 0 11:24:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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')]} 11:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:52 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 0x10178aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017914c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf30d819d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10162ed30>, '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 0x101492db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101625b20>, '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.7AKQu0qvoP/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.FdG1EuSS5D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 11:24:52 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 11:24:52 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 11:24:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7AKQu0qvoP/Render', 11:24:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:52 INFO - 'HOME': '/Users/cltbld', 11:24:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:52 INFO - 'LOGNAME': 'cltbld', 11:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:52 INFO - 'MOZ_NO_REMOTE': '1', 11:24:52 INFO - 'NO_EM_RESTART': '1', 11:24:52 INFO - 'PAGER': '/bin/cat', 11:24:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:52 INFO - 'PWD': '/builds/slave/test', 11:24:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:52 INFO - 'SHELL': '/bin/bash', 11:24:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdG1EuSS5D/Listeners', 11:24:52 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 11:24:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:52 INFO - 'USER': 'cltbld', 11:24:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:52 INFO - 'XPC_FLAGS': '0x0', 11:24:52 INFO - 'XPC_SERVICE_NAME': '0', 11:24:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:52 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-piisEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:52 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-Q7T3fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:52 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-dkWEit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:52 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-AaaXAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:52 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-aCyb_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:52 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-8w655I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:52 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-HWlLH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:53 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-MnxrU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:53 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-PL_K3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:53 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-5DLvXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:53 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-3aJiX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:53 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-v_cEm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:53 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-zG6bjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:53 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-I31TlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:53 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-Jmuyda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:53 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-5kIPGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:53 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-nEpUNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:24:54 INFO - Running setup.py install for manifestparser 11:24:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:24:54 INFO - Running setup.py install for mozcrash 11:24:54 INFO - Running setup.py install for mozdebug 11:24:54 INFO - Running setup.py install for mozdevice 11:24:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:24:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:24:54 INFO - Running setup.py install for mozfile 11:24:54 INFO - Running setup.py install for mozhttpd 11:24:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:24:54 INFO - Running setup.py install for mozinfo 11:24:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:24:55 INFO - Running setup.py install for mozInstall 11:24:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:24:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:24:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:24:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:24:55 INFO - Running setup.py install for mozleak 11:24:55 INFO - Running setup.py install for mozlog 11:24:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:24:55 INFO - Running setup.py install for moznetwork 11:24:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:24:55 INFO - Running setup.py install for mozprocess 11:24:55 INFO - Running setup.py install for mozprofile 11:24:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:24:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:24:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:24:56 INFO - Running setup.py install for mozrunner 11:24:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:24:56 INFO - Running setup.py install for mozscreenshot 11:24:56 INFO - Running setup.py install for moztest 11:24:56 INFO - Running setup.py install for mozversion 11:24:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:24:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:24:56 INFO - Cleaning up... 11:24:56 INFO - Return code: 0 11:24:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:56 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 0x10178aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017914c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf30d819d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10162ed30>, '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 0x101492db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101625b20>, '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.7AKQu0qvoP/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.FdG1EuSS5D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 11:24:56 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 11:24:56 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 11:24:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7AKQu0qvoP/Render', 11:24:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:56 INFO - 'HOME': '/Users/cltbld', 11:24:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:56 INFO - 'LOGNAME': 'cltbld', 11:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:56 INFO - 'MOZ_NO_REMOTE': '1', 11:24:56 INFO - 'NO_EM_RESTART': '1', 11:24:56 INFO - 'PAGER': '/bin/cat', 11:24:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:56 INFO - 'PWD': '/builds/slave/test', 11:24:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:56 INFO - 'SHELL': '/bin/bash', 11:24:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdG1EuSS5D/Listeners', 11:24:56 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 11:24:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:56 INFO - 'USER': 'cltbld', 11:24:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:56 INFO - 'XPC_FLAGS': '0x0', 11:24:56 INFO - 'XPC_SERVICE_NAME': '0', 11:24:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:56 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-zZqnlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:57 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)) 11:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:57 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-gic16C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:57 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)) 11:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:57 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-rR1BSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:57 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)) 11:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:57 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-i4M8Zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:57 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)) 11:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:57 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-Rp23YA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:57 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)) 11:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:57 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-l4Z8xX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:57 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)) 11:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:57 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-7sCvq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:57 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)) 11:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:57 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-XjCf0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:57 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)) 11:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:57 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-wGTagO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:57 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)) 11:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:57 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-Y4nOvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:57 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)) 11:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:57 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-RiccjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:58 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)) 11:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:58 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-1u_i4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:58 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)) 11:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:58 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-foJD09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:58 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)) 11:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:58 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-UAhHZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:58 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)) 11:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:58 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-Jf2NiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:58 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)) 11:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:58 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-LswwaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:58 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)) 11:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:58 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-eF7q0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:58 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)) 11:24:58 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)) 11:24:58 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)) 11:24:58 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)) 11:24:58 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)) 11:24:58 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)) 11:24:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:25:00 INFO - Downloading blessings-1.6.tar.gz 11:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:25:01 INFO - Installing collected packages: blessings 11:25:01 INFO - Running setup.py install for blessings 11:25:01 INFO - Successfully installed blessings 11:25:01 INFO - Cleaning up... 11:25:01 INFO - Return code: 0 11:25:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:25:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:01 INFO - Reading from file tmpfile_stdout 11:25:01 INFO - Current package versions: 11:25:01 INFO - blessings == 1.6 11:25:01 INFO - blobuploader == 1.2.4 11:25:01 INFO - docopt == 0.6.1 11:25:01 INFO - manifestparser == 1.1 11:25:01 INFO - mozInstall == 1.12 11:25:01 INFO - mozcrash == 0.17 11:25:01 INFO - mozdebug == 0.1 11:25:01 INFO - mozdevice == 0.48 11:25:01 INFO - mozfile == 1.2 11:25:01 INFO - mozhttpd == 0.7 11:25:01 INFO - mozinfo == 0.9 11:25:01 INFO - mozleak == 0.1 11:25:01 INFO - mozlog == 3.1 11:25:01 INFO - moznetwork == 0.27 11:25:01 INFO - mozprocess == 0.22 11:25:01 INFO - mozprofile == 0.28 11:25:01 INFO - mozrunner == 6.11 11:25:01 INFO - mozscreenshot == 0.1 11:25:01 INFO - mozsystemmonitor == 0.0 11:25:01 INFO - moztest == 0.7 11:25:01 INFO - mozversion == 1.4 11:25:01 INFO - psutil == 3.1.1 11:25:01 INFO - requests == 1.2.3 11:25:01 INFO - wsgiref == 0.1.2 11:25:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:01 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 0x10178aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017914c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf30d819d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10162ed30>, '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 0x101492db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101625b20>, '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.7AKQu0qvoP/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.FdG1EuSS5D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 11:25:01 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 11:25:01 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 11:25:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7AKQu0qvoP/Render', 11:25:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:25:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:25:01 INFO - 'HOME': '/Users/cltbld', 11:25:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:25:01 INFO - 'LOGNAME': 'cltbld', 11:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:01 INFO - 'MOZ_NO_REMOTE': '1', 11:25:01 INFO - 'NO_EM_RESTART': '1', 11:25:01 INFO - 'PAGER': '/bin/cat', 11:25:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:01 INFO - 'PWD': '/builds/slave/test', 11:25:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:25:01 INFO - 'SHELL': '/bin/bash', 11:25:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdG1EuSS5D/Listeners', 11:25:01 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 11:25:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:25:01 INFO - 'USER': 'cltbld', 11:25:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:25:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:01 INFO - 'XPC_FLAGS': '0x0', 11:25:01 INFO - 'XPC_SERVICE_NAME': '0', 11:25:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:01 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)) 11:25:01 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)) 11:25:01 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)) 11:25:01 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)) 11:25:01 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)) 11:25:01 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)) 11:25:01 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)) 11:25:01 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)) 11:25:01 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)) 11:25:01 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)) 11:25:01 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)) 11:25:01 INFO - Cleaning up... 11:25:01 INFO - Return code: 0 11:25:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:01 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 0x10178aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017914c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf30d819d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10162ed30>, '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 0x101492db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101625b20>, '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.7AKQu0qvoP/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.FdG1EuSS5D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 11:25:01 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 11:25:01 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 11:25:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7AKQu0qvoP/Render', 11:25:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:25:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:25:01 INFO - 'HOME': '/Users/cltbld', 11:25:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:25:01 INFO - 'LOGNAME': 'cltbld', 11:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:01 INFO - 'MOZ_NO_REMOTE': '1', 11:25:01 INFO - 'NO_EM_RESTART': '1', 11:25:01 INFO - 'PAGER': '/bin/cat', 11:25:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:01 INFO - 'PWD': '/builds/slave/test', 11:25:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:25:01 INFO - 'SHELL': '/bin/bash', 11:25:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdG1EuSS5D/Listeners', 11:25:01 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 11:25:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:25:01 INFO - 'USER': 'cltbld', 11:25:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:25:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:01 INFO - 'XPC_FLAGS': '0x0', 11:25:01 INFO - 'XPC_SERVICE_NAME': '0', 11:25:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:02 INFO - Downloading/unpacking jsonschema 11:25:02 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 11:25:02 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 11:25:02 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 11:25:02 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 11:25:02 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 11:25:02 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 11:25:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:25:04 INFO - Downloading/unpacking functools32 (from jsonschema) 11:25:04 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 11:25:04 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 11:25:04 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 11:25:04 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 11:25:04 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 11:25:04 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 11:25:04 INFO - Downloading functools32-3.2.3-2.tar.gz 11:25:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:25:05 INFO - warning: no files found matching '*.txt' 11:25:05 INFO - no previously-included directories found matching 'build' 11:25:05 INFO - no previously-included directories found matching 'dist' 11:25:05 INFO - no previously-included directories found matching '.git*' 11:25:05 INFO - Installing collected packages: jsonschema, functools32 11:25:05 INFO - Running setup.py install for functools32 11:25:05 INFO - warning: no files found matching '*.txt' 11:25:05 INFO - no previously-included directories found matching 'build' 11:25:05 INFO - no previously-included directories found matching 'dist' 11:25:05 INFO - no previously-included directories found matching '.git*' 11:25:05 INFO - Successfully installed jsonschema functools32 11:25:05 INFO - Cleaning up... 11:25:05 INFO - Return code: 0 11:25:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:05 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 0x10178aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017914c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf30d819d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10162ed30>, '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 0x101492db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101625b20>, '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.7AKQu0qvoP/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.FdG1EuSS5D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 11:25:05 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 11:25:05 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 11:25:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7AKQu0qvoP/Render', 11:25:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:25:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:25:05 INFO - 'HOME': '/Users/cltbld', 11:25:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:25:05 INFO - 'LOGNAME': 'cltbld', 11:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:05 INFO - 'MOZ_NO_REMOTE': '1', 11:25:05 INFO - 'NO_EM_RESTART': '1', 11:25:05 INFO - 'PAGER': '/bin/cat', 11:25:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:05 INFO - 'PWD': '/builds/slave/test', 11:25:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:25:05 INFO - 'SHELL': '/bin/bash', 11:25:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdG1EuSS5D/Listeners', 11:25:05 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 11:25:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:25:05 INFO - 'USER': 'cltbld', 11:25:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:25:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:05 INFO - 'XPC_FLAGS': '0x0', 11:25:05 INFO - 'XPC_SERVICE_NAME': '0', 11:25:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:05 INFO - Downloading/unpacking flake8 11:25:05 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 11:25:05 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 11:25:05 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 11:25:05 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 11:25:05 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 11:25:05 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 11:25:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:25:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:25:08 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 11:25:08 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 11:25:08 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 11:25:08 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 11:25:08 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 11:25:08 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 11:25:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:25:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:25:08 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 11:25:08 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 11:25:08 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 11:25:08 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 11:25:08 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 11:25:08 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 11:25:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:25:08 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 11:25:08 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 11:25:08 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 11:25:08 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 11:25:08 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 11:25:08 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 11:25:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:25:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:25:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:25:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:25:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:25:09 INFO - no previously-included directories found matching 'docs/_build' 11:25:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:25:09 INFO - Running setup.py install for pep8 11:25:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:25:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:25:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:25:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:25:09 INFO - no previously-included directories found matching 'docs/_build' 11:25:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:25:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:25:09 INFO - Cleaning up... 11:25:09 INFO - Return code: 0 11:25:09 INFO - Running post-action listener: _resource_record_post_action 11:25:09 INFO - Running post-action listener: _start_resource_monitoring 11:25:09 INFO - Starting resource monitoring. 11:25:09 INFO - ##### 11:25:09 INFO - ##### Running install step. 11:25:09 INFO - ##### 11:25:09 INFO - Running pre-action listener: _resource_record_pre_action 11:25:09 INFO - Running main action method: install 11:25:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:09 INFO - Reading from file tmpfile_stdout 11:25:09 INFO - Detecting whether we're running mozinstall >=1.0... 11:25:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:25:10 INFO - Reading from file tmpfile_stdout 11:25:10 INFO - Output received: 11:25:10 INFO - Usage: mozinstall [options] installer 11:25:10 INFO - Options: 11:25:10 INFO - -h, --help show this help message and exit 11:25:10 INFO - -d DEST, --destination=DEST 11:25:10 INFO - Directory to install application into. [default: 11:25:10 INFO - "/builds/slave/test"] 11:25:10 INFO - --app=APP Application being installed. [default: firefox] 11:25:10 INFO - mkdir: /builds/slave/test/build/application 11:25:10 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'] 11:25:10 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 11:25:42 INFO - Reading from file tmpfile_stdout 11:25:42 INFO - Output received: 11:25:42 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 11:25:42 INFO - Running post-action listener: _resource_record_post_action 11:25:42 INFO - ##### 11:25:42 INFO - ##### Running run-tests step. 11:25:42 INFO - ##### 11:25:42 INFO - Running pre-action listener: _resource_record_pre_action 11:25:42 INFO - Running main action method: run_tests 11:25:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:25:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:25:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:25:42 INFO - 2016-03-18 11:25:42.021 screenresolution[1641:7625] starting screenresolution argv=screenresolution get 11:25:42 INFO - 2016-03-18 11:25:42.023 screenresolution[1641:7625] Display 0: 1600x1200x32@60 11:25:42 INFO - 2016-03-18 11:25:42.029 screenresolution[1642:7627] starting screenresolution argv=screenresolution list 11:25:42 INFO - Available Modes on Display 0 11:25:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:25:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:25:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:25:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:25:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:25:42 INFO - Intel Iris: 11:25:42 INFO - Chipset Model: Intel Iris 11:25:42 INFO - Type: GPU 11:25:42 INFO - Bus: Built-In 11:25:42 INFO - VRAM (Dynamic, Max): 1536 MB 11:25:42 INFO - Vendor: Intel (0x8086) 11:25:42 INFO - Device ID: 0x0a2e 11:25:42 INFO - Revision ID: 0x0009 11:25:42 INFO - Displays: 11:25:42 INFO - Display: 11:25:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:25:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:25:42 INFO - Display Serial Number: 1600x1200 60 11:25:42 INFO - Main Display: Yes 11:25:42 INFO - Mirror: Off 11:25:42 INFO - Online: Yes 11:25:42 INFO - Rotation: Supported 11:25:42 INFO - Return code: 0 11:25:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:25:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:25:42 INFO - Python 2.7.3 11:25:42 INFO - Return code: 0 11:25:42 INFO - grabbing minidump binary from tooltool 11:25:42 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')]} 11:25:42 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 0x10162ed30>, '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 0x101492db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101625b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:25:42 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 11:25:42 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 11:25:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:25:42 INFO - Return code: 0 11:25:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:25:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:25:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:25:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:25:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:25:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:25:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:25:43 INFO - Return code: 0 11:25:43 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/P5cezEc_TfuG9sa4gmb0zg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0089', '--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 11:25:43 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/P5cezEc_TfuG9sa4gmb0zg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0089 --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 11:25:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7AKQu0qvoP/Render', 11:25:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:25:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:25:43 INFO - 'HOME': '/Users/cltbld', 11:25:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:25:43 INFO - 'LOGNAME': 'cltbld', 11:25:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:43 INFO - 'MOZ_NO_REMOTE': '1', 11:25:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:43 INFO - 'NO_EM_RESTART': '1', 11:25:43 INFO - 'PAGER': '/bin/cat', 11:25:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:43 INFO - 'PWD': '/builds/slave/test', 11:25:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:25:43 INFO - 'SHELL': '/bin/bash', 11:25:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdG1EuSS5D/Listeners', 11:25:43 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 11:25:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:25:43 INFO - 'USER': 'cltbld', 11:25:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:25:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:43 INFO - 'XPC_FLAGS': '0x0', 11:25:43 INFO - 'XPC_SERVICE_NAME': '0', 11:25:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:25:43 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/P5cezEc_TfuG9sa4gmb0zg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0089', '--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 11:25:43 INFO - mozversion application_buildid: 20160318090116 11:25:43 INFO - mozversion application_changeset: 854a8a7e9606c5e5dc0eaa6a67cd52b19d58f51f 11:25:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:25:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:25:43 INFO - mozversion application_name: Firefox 11:25:43 INFO - mozversion application_remotingname: firefox-dev 11:25:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:25:43 INFO - mozversion application_vendor: Mozilla 11:25:43 INFO - mozversion application_version: 47.0a2 11:25:43 INFO - mozversion platform_buildid: 20160318090116 11:25:43 INFO - mozversion platform_changeset: 854a8a7e9606c5e5dc0eaa6a67cd52b19d58f51f 11:25:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:25:43 INFO - mozversion platform_version: 47.0a2 11:25:43 INFO - using testdate: 1458325543 11:25:43 INFO - actual date: 1458325543 11:25:43 INFO - starting webserver on 'localhost:49274' 11:25:43 INFO - SUITE-START | Running 2 tests 11:25:43 INFO - TEST-START | dromaeo_css 11:25:43 INFO - operating with platform_type : mac_ 11:25:43 INFO - Initialising browser for dromaeo_css test... 11:25:43 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/tmpseAd6B/profile http://localhost:49274/getInfo.html) 11:25:46 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 11:25:46 INFO - PROCESS | 1660 | colorDepth:24 11:25:46 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 11:25:46 INFO - PROCESS | 1660 | __metrics 11:25:46 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" 11:25:46 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] 11:25:46 INFO - TEST-INFO | 1660: exit 0 11:25:46 INFO - Browser initialized. 11:25:46 INFO - Running cycle 1/1 for dromaeo_css test... 11:25:46 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/tmpseAd6B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:58 INFO - PROCESS | 1662 | RSS: Main: 210542592 11:25:58 INFO - PROCESS | 1662 | 11:26:49 INFO - PROCESS | 1662 | 1458325609711 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] 11:28:59 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 11:29:01 INFO - PROCESS | 1662 | RSS: Main: 320745472 11:29:01 INFO - PROCESS | 1662 | 11:32:03 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 11:32:04 INFO - PROCESS | 1662 | RSS: Main: 344907776 11:32:04 INFO - PROCESS | 1662 | 11:35:06 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 11:35:06 INFO - PROCESS | 1662 | RSS: Main: 348532736 11:35:06 INFO - PROCESS | 1662 | 11:38:08 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 11:38:09 INFO - PROCESS | 1662 | RSS: Main: 321724416 11:38:09 INFO - PROCESS | 1662 | 11:41:12 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 11:41:13 INFO - PROCESS | 1662 | RSS: Main: 308682752 11:41:13 INFO - PROCESS | 1662 | 11:44:15 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 11:44:15 INFO - PROCESS | 1662 | RSS: Main: 350154752 11:44:15 INFO - PROCESS | 1662 | 11:44:15 INFO - PROCESS | 1662 | __start_tp_report 11:44:15 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 11:44:15 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 11:44:15 INFO - PROCESS | 1662 | |i|pagename|runs| 11:44:15 INFO - PROCESS | 1662 | |0;dojo.html;2747.0797282910225;3491.7555771096036;3504.456809194575;3528.7882727036394;3570.268095040517;5721.313442386909;5729.656220626765;5732.168835518853;5741.397153298895;5764.250647415841;5710.2862142232225;5729;5740.885182296352;5755.568332375067;5765.481106700396;5118.616103792221;5124.795008199668;5155.793768249266;5175.430702622709;5189.636725429203;5243.6853788772605;5259.868503287429;5261.210818377236;5262.184361423985;5271.710055946922;5162.638615296931;5169.095408303532;5189.922151167735;5207.114790485608;5255;5215.504527069922;5263.36839579253;5268.841934741964;5272.815451459181;5279.973600132013;5005.57452616528;5178.249153872667;5183.326167598226;5211.348581427322;5222.712750798704;5579.442055794429;5630.408807075239;5656.604037717361;5657.519110875581;5662.065759149736;6182.474489668383;6312;6315.778947736807;6325.367463253684;6343.936560634381;6191.133241346215;6227.688615569204;6243.906341404882;6271.090691849702;6271.749130034793;5871.970640146772;5873.500752436048;5887.941120588825;5932.406759324033;5934.465898069108;6214;6272.905906411407;6319.431251187323;6322.462590679752;6333.556651034383;6228.377162283736;6259.217597800275;6262.812115636538;6266.248050234001;6268.435840774352;6253.437190652863;6265.404786545271;6267.2165979252595;6271.341509141565;6276.717547710364;6146.631202127886;6187.969060154671;6241.313455519889;6284.025975973731;6306.9684651576445;6213.254409470893;6233.657148856856;6241.906371404432;6250.968745156245;6258.906116408258;4899.118158731391;4907.312976183337;4919;4923.064617722621;4962.727050012284;4390.121975604892;4439.200943830077;4466.151431228056;4498.955010449854;4512.503624601291;5748.367679555246;5814.680192589448;5818.7672493100645;5821.854453638693;5841.386654401312;6232.906506402317;6252;6254.6247225166635;6256.405641464054;6265.686715664289;5695.658260504383;5763.366029736726;5771.509421699118;5826.446487583673;5836.708164591839;5413.891722165535;5420.593455490775;5426.945730542644;5428.185772134132;5432.130859062531;6359.7456101755415;6364.968175159187;6369.299377068519;6370.394812492806;6380.489560835122;6178.567500274938;6197.101420293942;6225.128482012612;6263.248410190807;6269.749210031548;6350.7459701611415;6355.936440635534;6358.078078678658;6358.300586935526;6372.808815735535;6231.813045608639;6234.407731265523;6242.3133455320785;6270.843228919313;6272.278687950944;5293.841184764463;5733.455321744427;6143.788236235041;6240.188775459162;6262.2172228471445;6208.720607572761;6221.564490485623;6229.875402492015;6235.46998505114;6236.251649802053;6179.907301390573;6215.751369945332;6239.220097487814;6241.063840423973;6252.187215661935;5968.791092311748;6036.396360363929;6108.706347747117;6124.5406594506485;6131.754729810757;5114.667546609458;6201.441870231701;6220.564560480904;6228.968855155696;6243.937560624336;4931.2849636803185;6105.877882442415;6111.84720381994;6116.847078823065;6129.816105516842 11:44:15 INFO - PROCESS | 1662 | |1;ext.html;543.9936118181367;593.9516752931074;629.8425393651587;660.2044536333718;669.0098653992092;39087.022824429405;39402.21195576087;39591.60408395915;39607.99999999996;39639;42465.57534424662;42965.925851853644;42982.57017429825;43145.56854431455;43216.91957701059;9621.855672164924;9838.376667849832;9849.753756156082;9852.359596626233;9854.359466634645;8310.335173186131;9576;9742.025797420236;9760;9792.951035244849;9776.657816976407;9784.804303913954;9821.459819709913;9837.409755414697;9840.95079524605;8457.74626761195;9815.754606134833;9818.9509052455;9845.45849978251;9851.90148098517;9743.171830394354;9863.950680246624;9870.851937220947;9879.654212102541;9884.95057524715;41822;42176.78911605453;42190;42205;42219.15561688749;2550.426154115328;3051.969480305213;3404.8934096418516;3426.58880934287;3494.248736521635;28190.295242618893;28236.85881570579;28306.433871322664;29315.973940911965;29945.951891683904;2775.9028434004713;2820.9294767630972;2850.700676428966;2880.5967164596973;2934.7652187824924;362711;363543.36456635623;363694;364579;439791;57537.712311438176;58369;58461;75184.62407687926;76427.23572764313;72249;72411;72435.91346129813;72825;72846;18733.531661708566;18957.62084758297;18958.905205473886;18972.241110355706;18984.810151898306;14212.431502739775;14304.141751494944;14326.641833954234;14491.20298383599;14514.709705805824;22541.211057612905;22577.774222257896;22617.434564136027;22649.660255096187;22734.886325568266;9134.497602631918;9308.627654893728;9331.72004839856;9336.393134446374;9352.625894964125;1019.3934608907688;1067.9626213082504;1100.983485247722;1118.6755840806238;1165.551262763825;25589.744102559107;29961.850190748908;30153.396932061234;30643.2339191522;30648.846755766077;932.5150921520772;1049.9160067194607;1149.179193284165;1234.6789834642877;1264.3109505319624;12898.935505322414;13743.793843092362;14315.57053288403;14952.551423457313;14999.700006000037;530740;531055;531624;532266;534949;59442.70278648579;60622.090668640005;60728.69635651793;60729.69635151884;60923;1414.0949792133042;1441.5098866385479;1444.1768192130594;1532.1573134776052;1560.5240401677597;29453.410931781673;29896.701032990262;30194;30718.539221911244;30840.845795770878;47612;61058.38941610705;62233.68883155737;62272.06591901216;62286;372942.1352893218;378396;381036;381436;382187;30830;33757;33823;34707;34903.30193396067;45234.869128272054;46204.53795462002;46556.7672161637;47313.29030064621;48218;38609.80695096507;38661.80669096637;38957.415638764876;39391;39449.80275098606;38606.6139338603;38721.80639096787;38737.418938715375;38751.22497549977;39611;33337.666623333454;33827;34104.48843267303;34627.48058779171;34697.479537807456;32460.51309230316;32481.837590811894;32908.67091329056;33037;33253;24927.750722492543;25000.249992500256;25027.249182524552;25551.612096975758;25554.872225638752 11:44:15 INFO - PROCESS | 1662 | |2;jquery.html;341.25435922509337;384.85375557288233;389.83432041382406;392.758453551066;396.3123979894882;15620.609484762886;20513.897430512847;20714.689279660815;21063.578728425422;21232.893835530802;20597.279095231668;20728.27451039214;21357.786422135774;21393.46516337092;21408.678869816966;5759.510441612458;5950.761969521214;5999;6000.519958403317;6020.367861374536;5675.574331925101;5897.941020589804;5912.704364781765;5926.170336152942;5934.43622855828;5833.7083145842535;5858.5606079543995;5863.824085277449;5871.853203669921;5878.118282257674;5604.775808967657;5746.48281654651;5775.826725198251;5794.130880367937;5830.300363956331;5019.29729837823;5045.520675535819;5050;5052.621053420971;5076.111680455942;25782.742172578222;26190.73809261902;26512.734872651414;26542.336441588923;26572.601410978852;2241.7085778848646;2292.1862738727677;2321.570509455756;2636.934076648099;2653.3499292673228;9838.163756080741;10540.472976351228;15070.397184112622;15665.29506172225;16382.918085409498;1806.1240298455239;1806.7470554122433;1854.2582966813247;1857.071464267866;1878;102329.48835255776;103213.48393258061;104946;107277.85444291148;110778;11648.88351116478;11869.525218991144;11904.404779760976;11917.940410297893;11983.760324793455;13168.275744833934;13358.732825343634;14497.565073047825;14500.854991450162;14515.274236288144;9154.176124148726;9160.587773550205;9204.723858284262;9223.10926260115;9274.30442716799;9438.95280523593;9439.150476457151;9500.619975200914;9580.66467673628;9624.470654114091;4593.908121837545;4675.13510000651;4680.836170734008;4726.976365118152;4732.337472753818;1946.6593346164364;1954.7654281486314;1957.9216831326871;1959.9970258011692;1989.9005049747454;924.3390975452584;985.3348989432104;991.7768502086973;999.6601155607128;1011.5144730529387;20571.794282057286;20849;20903.895480522806;21103.894480527808;21171.47071323229;986.5954958466995;1026.5329275179774;1073.9677809665723;1079.83262594298;1092.792369449802;8787.692430764893;11190.104791616652;11210.21528493014;11210.495527701272;11287.774244515227;531122;632087;637739;653275;653728;113826.4308678468;119214;119321.40339298421;121483.78516214901;121791;1070.925035247525;1080.1574771677947;1118.072000239799;1138.8064029115071;1140.2246472398683;18009.337587013153;18163.27346906109;18493.630127397646;18557.628847423246;18656;50419.487415377596;51693.48306516887;51742.74128629333;51893.7405312971;52091;70992.64503677448;72198.63900680463;72820.63589682018;73960.63019684867;75585;6342;8360.87458688108;8498.362622803437;8544.40189186751;8801.29589632815;12739.681507962376;13134.343282835629;13421.932890335485;13453.192808431526;13855;5704.857378565403;8964.955175224082;11563.364014979257;11693;11902.809719028028;11675.416229188677;11734.239943535598;11768.470418831002;11845.466953987263;12174.57388991381;11903.16677832578;12040.397980100784;12101;12255.142140050111;12422.130450868352;8415.663373464993;8552.57237138153;8644.00593931706;8686.684383800703;8698;8726.65093396257;9179.862302065609;11070.557177713123;11793;11993.220440671328 11:44:15 INFO - PROCESS | 1662 | |3;mootools.html;1513.296317212496;1534.7084054029733;1680.7646929429882;2000.6098810731903;2100.590384874948;8477.78805529862;9137.543122843856;9280.582373793179;9288.767780805483;9293.442393456397;8876.15676510732;9154.450732956027;9165.725028249146;9166.908330916689;9171.449713017208;2171.185805323004;2591.922242332733;2596.31197732601;2598.22053383985;2601.557735185023;2527.064985955199;2610;2611.0861198580533;2616;2626.5928781038874;2594.377349436131;2612.4122072533623;2632.2629663694197;2632.473505298938;2637.3670319123366;2592.64999225105;2595.9480810383875;2616.5028644557474;2627.1067836935536;2631.5657916443765;2436.84160529565;2575.3304140923306;2602.2323414592743;2623.9868800656063;2626.684797824254;9357.39176953496;9411.917629472562;9419.293552983485;9424.434533927986;9434.622615095388;5628.971855140698;5811.564132690023;5858.41415858415;5867.8533036674;5881.67650779207;3750.13746838226;3826.4451654510217;3843.3466310727244;3871.845126194949;3875.302445559798;1065.6323568368978;1079.4602698650674;1085.4084523934475;1099.4228030284085;1126.8704099028635;12668.36658167088;12672.23966562;12679.239245645198;12724.982001439863;12730.427130779137;5039.118154322979;5047.192449208109;5120.462351453119;5141.794328226829;5163.586913046947;10779.137668986463;10818.24272300947;10820.891791082146;10821;10834.133269338434;5697.6296540724725;5738.741756620962;5753.712314384264;5754.136879468029;5759.884802303931;4636.698614590108;4811.965427433119;4997.825076122318;5178.818741344035;5190.403103643054;4106.244230711946;4164.979175104166;4173.640219623232;4211.7472951623;4222.662187025031;1341.7920222365549;1364.87716105549;1365.8907287416982;1373;1375.113052081402;1085.4138765066934;1100.625787232345;1207.0705556721275;1223.5044806853239;1365.3173413293352;8278.71024514139;8332.791680207922;8379.329653627696;8381.329493640495;8383.03595086573;1257.1074537078593;1263.128441375448;1265.1776345375395;1290.3548225887057;1302.4139137388213;6216.564840461125;6278.30938596754;6319.905201421982;6325.335839736761;6339.651319177489;11042;11279.32324060559;11439.828402573969;11582.36297003656;11691.473883675255;11334.886651133384;11386;11425.828612570818;11518.308901465938;11540.942295288638;8362.289205417608;8545.529995850164;8752.956235218782;8762.518061506551;8817.823643527221;8409.990801103906;8419.8737018946;8421.831563368822;8484.490930544187;8527.445716028438;9774.560144793359;9912.35569687968;10018.849717254392;10072.496375181358;10191.796164076824;10116.696499105039;10446.895531044896;10459.581616735246;10469.26715129964;10617.203709721956;7210.206877243394;7642.312191902755;7957.204279571996;7992.240737129963;8121.9593902032475;8634.697785577475;8636.827263454821;8704.042555318783;8712.91287087121;8719.564021799011;7185.958036084843;7573.886391704019;7770.572618506037;7916.406269529693;8078;5616.354119276336;7143.464240182111;7507.962460187664;7604.885926711215;7738.458307918391;8002.239787220205;8157;8162.591870406574;8166.265036146538;8169.428140030141;7265.346118849329;7354.338109570164;7370.852582948418;7372.741954031798;7379.077615298088;7470.3276705096805;7496.025516683015;7497.175310715707;7497.437692173218;7504.474686771873 11:44:15 INFO - PROCESS | 1662 | |4;prototype.html;341.45878782130325;347.51521627329873;350.33960983546007;352.2321339479934;354.9183687751817;6624.403803657676;6636.60180389177;6669.833254168649;6683.632400217992;6742.528023038377;6610.933890661092;6636.104125942997;6637.834054148649;6651.966740166293;6654.168228971379;4707.741074240916;4777.187878060738;4783.258594917794;4871.050145221683;4956.083124621957;4880.9755951220195;4898.265260210979;4911.5088491150955;4939.234418665094;4953.678010929296;4881.267809828536;4885.755712214393;4893.755312234392;4903.117438861003;4914.32169467641;4635.745034023127;4724.622030237607;4746.881327966794;4749.121412538691;4847.030593881203;4185.351270553069;4192.5807419258135;4206.41110244566;4225.492940847118;4227.91544169118;6259.998400255983;6348.396902294275;6361.268454127789;6361.300256971729;6393.168888044571;5889.057750759901;5892.911606325909;5902.291724992985;5906.734196961104;5918.40815918409;6838.863222735517;7097.92902070983;7106.324899134574;7119.53723008008;7128.144622645264;4789.137955168068;4826.734529600871;4832.613390928717;4837.927431088537;4838.830640927586;7433.442491813082;7509.0989081310045;7509.211532789033;7510.549367037941;7516.248375162495;4933.186024305949;4938.259261110862;4939.333190019373;4949.48030456804;4951.306817045616;4990.155611301523;5000.799968001239;5021.020900924358;5021.096202683552;5027.120253955543;5684.204211410323;5918.556108291896;5919.467247947706;5923.141144534018;5929.169916211734;7097.787066388017;7125.821854453577;7126.536775109601;7129.429645628441;7132.643367831588;1727.8337122442301;1754.877158598886;1757.5693954981111;1758.5867321179512;1759.0501129389986;1146.5070019891527;1148.8506494155706;1161.5702190189684;1174.518447436547;1178.664080737003;5772.701142242961;6082.543809214327;6583.637899915455;6588.24235212947;6588.604683718992;6824.624645644438;6833.829154271183;7324.67038983247;7494.587797671072;7500.512466689757;5671.291088613923;6552.148220731275;6691.130153080068;6697.966510167418;6700.430463410665;3887.455756194135;3931.724779265481;3937.2322397132284;3940.724149309578;3944.487216661873;6348.04779283102;6517.576357536745;6633.668316584151;7501.0291494325365;7729.922700773032;7645.426593005547;7690.423218258653;7695.115061767857;7696.538207707556;7700.306972372513;7703.422243331885;7704.229577042363;7708.691652333844;7713.4600577959;7722.189170137167;7406.259374062766;7426.4430167736555;7439.293267139613;7444.702211911463;7452;7001.5799052055;7309.232530584425;7349.154847192642;7351.228121047213;7358.22738612438;7684.807879802826;7737.3036426721865;7779.066512018594;7783.377329813488;7789.143194248515;4725.976370118127;4772.427308722976;4772.665913386029;4782.306565547907;4788.3056956741775;7428.1086269647985;7435.442341824277;7437.367823735043;7437.367823735043;7451.217622149813;6850.862982740417;7142.285771422816;7174.533655312388;7198.6400679964745;7200.135983681992;6073.605215660968;6935.549189302679;7181.569105853666;7184.856302873809;7189.676464559003;6992.056072430157;7008.859822803617;7016.5088443808445;7025.402840758593;7028.929710702828;6927.238003819677;7138.500304978602;7143.357097861218;7160.391366733886;7163.140423149047;6699.8325041872395;6846.315368463114;6849.075374824335;7039.260877607778;7044.15470143586 11:44:15 INFO - PROCESS | 1662 | |5;yui.html;731.2943009995354;752.2477522477519;793.1592511937343;800;805.110353059869;15086.245687715611;15409.46066887659;15412.152331621757;15420.691586168285;15456.69086618267;14499;14524.3464044118;15293.464728734496;16387.91806040968;16398.016119032865;969.7187815533487;980.3039841712392;995.4027583449945;995.4674249276638;996.0238965813508;988.5008070924173;989.213575207708;993.6869885985927;994.3337963564429;996.875390576178;1048.5491238767327;1050.4642632257528;1055.2191378379982;1058.0636137018755;1058.7935352606246;1039.9376037437778;1040.7242080848582;1041.6822869024945;1042.8331466965249;1044.8380501022355;781.9022622172229;782.8669126248494;783.7844592737043;785.9174786647434;787.189195129018;14967.550973470814;15191.544253672408;15275.465358712392;15429.151396673178;15466.45867394647;12953.158044727063;13122.60632181036;13138.802917956238;13369.933150334284;13449.313820622976;10091.79816403675;10133.594656213743;10316.742081447948;10446.791064178673;10624.681259562225;3583.157957879896;3604.4232922732235;3658.560972683295;3676.5220521332058;3819.4652748615217;66694.6661066776;72219.63890180516;81910.18089819085;82203;82328.3534329316;9569.712908612753;9595.944446110921;9609.375390599589;9838.260791357943;9853.014698530089;22932.541349172923;22984.4253893654;22991.08035678554;23005.96473158712;23007.194748183734;7580.393568514505;7628.8474230516185;7708.9229107709325;7826.530408175414;7869;4124.566920473367;4186.91626167475;4257.40396344512;4298.376735373354;4460.531644177379;3677.5219221501034;3712.053426376257;3728.5712143103347;3735.5143831301757;3741.0273328934127;640.961542307463;647.1134545672459;659.041095206483;660.4287291492824;663.3333499832734;597.8027251007157;615.3262177915176;625.6558892609047;627.159606127791;635.4789072960128;8208.630611622491;8255.793605159919;8411.621477033548;8506.064332923374;8750.168733970262;595.8897603943284;602.629382929504;608.1850320570456;639.9808005759835;642.1651852591613;2981.3142977114953;3591.7665351752053;3609.242059167604;3938.487996560486;4144.564820693844;91340.54329728309;96940.54589181168;97887;98946;99509.50245248727;72719;83136;83993;84354.5782271097;85466.14533854707;73263;73627.52744945072;74402.13994650177;76052;76052.61973690207;8667.219950204511;8731.476111433334;8796.164364385373;8980.730578082668;9006;49995;52524.474755251955;52774.73612631912;54114;54763;70738;75649.24350756421;75951;76844.61577692076;78394.6080269595;11191;11501.654950351503;11513.769724605294;11562.691919092103;11608.767824643292;10139.7465063374;11964;12070.698232544257;12426.502939882303;12574.30841303737;11411.429428528707;11612.187146899636;11641.6507504775;11706.063514918616;11873.762524749629;11691.883081169079;11828.763424731285;11975.580854670045;12013.459394327101;12049.096317776026;11438.08495320389;11480.655580332603;11612.187146899636;11618.535258589562;12227;9574.036109378017;9667.81759733297;10062.647807326708;10121.291509594552;10298.485075746332;9686.321957463191;9885.604575817175;9893.703188904057;9984.500774961369;9993.400395975974 11:44:15 INFO - PROCESS | 1662 | __end_tp_report 11:44:15 INFO - PROCESS | 1662 | __start_cc_report 11:44:15 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1023 11:44:15 INFO - PROCESS | 1662 | __end_cc_report 11:44:15 INFO - PROCESS | 1662 | __startTimestamp1458326655918__endTimestamp 11:44:15 INFO - PROCESS | 1662 | 11:44:15 INFO - PROCESS | 1662 | ------- Summary: start ------- 11:44:15 INFO - PROCESS | 1662 | Number of tests: 6 11:44:15 INFO - PROCESS | 1662 | 11:44:15 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5770.76 Median:6108.71 stddev:660.73 (10.8%) stddev-sans-first:618.72 11:44:15 INFO - PROCESS | 1662 | Values: 2747.1 3491.8 3504.5 3528.8 3570.3 5721.3 5729.7 5732.2 5741.4 5764.3 5710.3 5729.0 5740.9 5755.6 5765.5 5118.6 5124.8 5155.8 5175.4 5189.6 5243.7 5259.9 5261.2 5262.2 5271.7 5162.6 5169.1 5189.9 5207.1 5255.0 5215.5 5263.4 5268.8 5272.8 5280.0 5005.6 5178.2 5183.3 5211.3 5222.7 5579.4 5630.4 5656.6 5657.5 5662.1 6182.5 6312.0 6315.8 6325.4 6343.9 6191.1 6227.7 6243.9 6271.1 6271.7 5872.0 5873.5 5887.9 5932.4 5934.5 6214.0 6272.9 6319.4 6322.5 6333.6 6228.4 6259.2 6262.8 6266.2 6268.4 6253.4 6265.4 6267.2 6271.3 6276.7 6146.6 6188.0 6241.3 6284.0 6307.0 6213.3 6233.7 6241.9 6251.0 6258.9 4899.1 4907.3 4919.0 4923.1 4962.7 4390.1 4439.2 4466.2 4499.0 4512.5 5748.4 5814.7 5818.8 5821.9 5841.4 6232.9 6252.0 6254.6 6256.4 6265.7 5695.7 5763.4 5771.5 5826.4 5836.7 5413.9 5420.6 5426.9 5428.2 5432.1 6359.7 6365.0 6369.3 6370.4 6380.5 6178.6 6197.1 6225.1 6263.2 6269.7 6350.7 6355.9 6358.1 6358.3 6372.8 6231.8 6234.4 6242.3 6270.8 6272.3 5293.8 5733.5 6143.8 6240.2 6262.2 6208.7 6221.6 6229.9 6235.5 6236.3 6179.9 6215.8 6239.2 6241.1 6252.2 5968.8 6036.4 6108.7 6124.5 6131.8 5114.7 6201.4 6220.6 6229.0 6243.9 4931.3 6105.9 6111.8 6116.8 6129.8 11:44:15 INFO - PROCESS | 1662 | 11:44:15 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:59696.04 Median:38691.81 stddev:115645.86 (298.9%) stddev-sans-first:115885.00 11:44:15 INFO - PROCESS | 1662 | Values: 544.0 594.0 629.8 660.2 669.0 39087.0 39402.2 39591.6 39608.0 39639.0 42465.6 42965.9 42982.6 43145.6 43216.9 9621.9 9838.4 9849.8 9852.4 9854.4 8310.3 9576.0 9742.0 9760.0 9793.0 9776.7 9784.8 9821.5 9837.4 9841.0 8457.7 9815.8 9819.0 9845.5 9851.9 9743.2 9864.0 9870.9 9879.7 9885.0 41822.0 42176.8 42190.0 42205.0 42219.2 2550.4 3052.0 3404.9 3426.6 3494.2 28190.3 28236.9 28306.4 29316.0 29946.0 2775.9 2820.9 2850.7 2880.6 2934.8 362711.0 363543.4 363694.0 364579.0 439791.0 57537.7 58369.0 58461.0 75184.6 76427.2 72249.0 72411.0 72435.9 72825.0 72846.0 18733.5 18957.6 18958.9 18972.2 18984.8 14212.4 14304.1 14326.6 14491.2 14514.7 22541.2 22577.8 22617.4 22649.7 22734.9 9134.5 9308.6 9331.7 9336.4 9352.6 1019.4 1068.0 1101.0 1118.7 1165.6 25589.7 29961.9 30153.4 30643.2 30648.8 932.5 1049.9 1149.2 1234.7 1264.3 12898.9 13743.8 14315.6 14952.6 14999.7 530740.0 531055.0 531624.0 532266.0 534949.0 59442.7 60622.1 60728.7 60729.7 60923.0 1414.1 1441.5 1444.2 1532.2 1560.5 29453.4 29896.7 30194.0 30718.5 30840.8 47612.0 61058.4 62233.7 62272.1 62286.0 372942.1 378396.0 381036.0 381436.0 382187.0 30830.0 33757.0 33823.0 34707.0 34903.3 45234.9 46204.5 46556.8 47313.3 48218.0 38609.8 38661.8 38957.4 39391.0 39449.8 38606.6 38721.8 38737.4 38751.2 39611.0 33337.7 33827.0 34104.5 34627.5 34697.5 32460.5 32481.8 32908.7 33037.0 33253.0 24927.8 25000.2 25027.2 25551.6 25554.9 11:44:15 INFO - PROCESS | 1662 | 11:44:15 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:35109.01 Median:2306.88 stddev:103252.05 (4475.8%) stddev-sans-first:103508.70 11:44:15 INFO - PROCESS | 1662 | Values: 341.3 384.9 389.8 392.8 396.3 15620.6 20513.9 20714.7 21063.6 21232.9 20597.3 20728.3 21357.8 21393.5 21408.7 5759.5 5950.8 5999.0 6000.5 6020.4 5675.6 5897.9 5912.7 5926.2 5934.4 5833.7 5858.6 5863.8 5871.9 5878.1 5604.8 5746.5 5775.8 5794.1 5830.3 5019.3 5045.5 5050.0 5052.6 5076.1 25782.7 26190.7 26512.7 26542.3 26572.6 2241.7 2292.2 2321.6 2636.9 2653.3 9838.2 10540.5 15070.4 15665.3 16382.9 1806.1 1806.7 1854.3 1857.1 1878.0 102329.5 103213.5 104946.0 107277.9 110778.0 11648.9 11869.5 11904.4 11917.9 11983.8 13168.3 13358.7 14497.6 14500.9 14515.3 9154.2 9160.6 9204.7 9223.1 9274.3 9439.0 9439.2 9500.6 9580.7 9624.5 4593.9 4675.1 4680.8 4727.0 4732.3 1946.7 1954.8 1957.9 1960.0 1989.9 924.3 985.3 991.8 999.7 1011.5 20571.8 20849.0 20903.9 21103.9 21171.5 986.6 1026.5 1074.0 1079.8 1092.8 8787.7 11190.1 11210.2 11210.5 11287.8 531122.0 632087.0 637739.0 653275.0 653728.0 113826.4 119214.0 119321.4 121483.8 121791.0 1070.9 1080.2 1118.1 1138.8 1140.2 18009.3 18163.3 18493.6 18557.6 18656.0 50419.5 51693.5 51742.7 51893.7 52091.0 70992.6 72198.6 72820.6 73960.6 75585.0 6342.0 8360.9 8498.4 8544.4 8801.3 12739.7 13134.3 13421.9 13453.2 13855.0 5704.9 8965.0 11563.4 11693.0 11902.8 11675.4 11734.2 11768.5 11845.5 12174.6 11903.2 12040.4 12101.0 12255.1 12422.1 8415.7 8552.6 8644.0 8686.7 8698.0 8726.7 9179.9 11070.6 11793.0 11993.2 11:44:15 INFO - PROCESS | 1662 | 11:44:15 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:6378.80 Median:5018.47 stddev:3377.32 (67.3%) stddev-sans-first:3366.99 11:44:15 INFO - PROCESS | 1662 | Values: 1513.3 1534.7 1680.8 2000.6 2100.6 8477.8 9137.5 9280.6 9288.8 9293.4 8876.2 9154.5 9165.7 9166.9 9171.4 2171.2 2591.9 2596.3 2598.2 2601.6 2527.1 2610.0 2611.1 2616.0 2626.6 2594.4 2612.4 2632.3 2632.5 2637.4 2592.6 2595.9 2616.5 2627.1 2631.6 2436.8 2575.3 2602.2 2624.0 2626.7 9357.4 9411.9 9419.3 9424.4 9434.6 5629.0 5811.6 5858.4 5867.9 5881.7 3750.1 3826.4 3843.3 3871.8 3875.3 1065.6 1079.5 1085.4 1099.4 1126.9 12668.4 12672.2 12679.2 12725.0 12730.4 5039.1 5047.2 5120.5 5141.8 5163.6 10779.1 10818.2 10820.9 10821.0 10834.1 5697.6 5738.7 5753.7 5754.1 5759.9 4636.7 4812.0 4997.8 5178.8 5190.4 4106.2 4165.0 4173.6 4211.7 4222.7 1341.8 1364.9 1365.9 1373.0 1375.1 1085.4 1100.6 1207.1 1223.5 1365.3 8278.7 8332.8 8379.3 8381.3 8383.0 1257.1 1263.1 1265.2 1290.4 1302.4 6216.6 6278.3 6319.9 6325.3 6339.7 11042.0 11279.3 11439.8 11582.4 11691.5 11334.9 11386.0 11425.8 11518.3 11540.9 8362.3 8545.5 8753.0 8762.5 8817.8 8410.0 8419.9 8421.8 8484.5 8527.4 9774.6 9912.4 10018.8 10072.5 10191.8 10116.7 10446.9 10459.6 10469.3 10617.2 7210.2 7642.3 7957.2 7992.2 8122.0 8634.7 8636.8 8704.0 8712.9 8719.6 7186.0 7573.9 7770.6 7916.4 8078.0 5616.4 7143.5 7508.0 7604.9 7738.5 8002.2 8157.0 8162.6 8166.3 8169.4 7265.3 7354.3 7370.9 7372.7 7379.1 7470.3 7496.0 7497.2 7497.4 7504.5 11:44:15 INFO - PROCESS | 1662 | 11:44:15 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:5852.58 Median:6617.67 stddev:1826.45 (27.6%) stddev-sans-first:1784.12 11:44:15 INFO - PROCESS | 1662 | Values: 341.5 347.5 350.3 352.2 354.9 6624.4 6636.6 6669.8 6683.6 6742.5 6610.9 6636.1 6637.8 6652.0 6654.2 4707.7 4777.2 4783.3 4871.1 4956.1 4881.0 4898.3 4911.5 4939.2 4953.7 4881.3 4885.8 4893.8 4903.1 4914.3 4635.7 4724.6 4746.9 4749.1 4847.0 4185.4 4192.6 4206.4 4225.5 4227.9 6260.0 6348.4 6361.3 6361.3 6393.2 5889.1 5892.9 5902.3 5906.7 5918.4 6838.9 7097.9 7106.3 7119.5 7128.1 4789.1 4826.7 4832.6 4837.9 4838.8 7433.4 7509.1 7509.2 7510.5 7516.2 4933.2 4938.3 4939.3 4949.5 4951.3 4990.2 5000.8 5021.0 5021.1 5027.1 5684.2 5918.6 5919.5 5923.1 5929.2 7097.8 7125.8 7126.5 7129.4 7132.6 1727.8 1754.9 1757.6 1758.6 1759.1 1146.5 1148.9 1161.6 1174.5 1178.7 5772.7 6082.5 6583.6 6588.2 6588.6 6824.6 6833.8 7324.7 7494.6 7500.5 5671.3 6552.1 6691.1 6698.0 6700.4 3887.5 3931.7 3937.2 3940.7 3944.5 6348.0 6517.6 6633.7 7501.0 7729.9 7645.4 7690.4 7695.1 7696.5 7700.3 7703.4 7704.2 7708.7 7713.5 7722.2 7406.3 7426.4 7439.3 7444.7 7452.0 7001.6 7309.2 7349.2 7351.2 7358.2 7684.8 7737.3 7779.1 7783.4 7789.1 4726.0 4772.4 4772.7 4782.3 4788.3 7428.1 7435.4 7437.4 7437.4 7451.2 6850.9 7142.3 7174.5 7198.6 7200.1 6073.6 6935.5 7181.6 7184.9 7189.7 6992.1 7008.9 7016.5 7025.4 7028.9 6927.2 7138.5 7143.4 7160.4 7163.1 6699.8 6846.3 6849.1 7039.3 7044.2 11:44:15 INFO - PROCESS | 1662 | 11:44:15 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:19094.73 Median:53444.37 stddev:26868.14 (50.3%) stddev-sans-first:26908.13 11:44:15 INFO - PROCESS | 1662 | Values: 731.3 752.2 793.2 800.0 805.1 15086.2 15409.5 15412.2 15420.7 15456.7 14499.0 14524.3 15293.5 16387.9 16398.0 969.7 980.3 995.4 995.5 996.0 988.5 989.2 993.7 994.3 996.9 1048.5 1050.5 1055.2 1058.1 1058.8 1039.9 1040.7 1041.7 1042.8 1044.8 781.9 782.9 783.8 785.9 787.2 14967.6 15191.5 15275.5 15429.2 15466.5 12953.2 13122.6 13138.8 13369.9 13449.3 10091.8 10133.6 10316.7 10446.8 10624.7 3583.2 3604.4 3658.6 3676.5 3819.5 66694.7 72219.6 81910.2 82203.0 82328.4 9569.7 9595.9 9609.4 9838.3 9853.0 22932.5 22984.4 22991.1 23006.0 23007.2 7580.4 7628.8 7708.9 7826.5 7869.0 4124.6 4186.9 4257.4 4298.4 4460.5 3677.5 3712.1 3728.6 3735.5 3741.0 641.0 647.1 659.0 660.4 663.3 597.8 615.3 625.7 627.2 635.5 8208.6 8255.8 8411.6 8506.1 8750.2 595.9 602.6 608.2 640.0 642.2 2981.3 3591.8 3609.2 3938.5 4144.6 91340.5 96940.5 97887.0 98946.0 99509.5 72719.0 83136.0 83993.0 84354.6 85466.1 73263.0 73627.5 74402.1 76052.0 76052.6 8667.2 8731.5 8796.2 8980.7 9006.0 49995.0 52524.5 52774.7 54114.0 54763.0 70738.0 75649.2 75951.0 76844.6 78394.6 11191.0 11501.7 11513.8 11562.7 11608.8 10139.7 11964.0 12070.7 12426.5 12574.3 11411.4 11612.2 11641.7 11706.1 11873.8 11691.9 11828.8 11975.6 12013.5 12049.1 11438.1 11480.7 11612.2 11618.5 12227.0 9574.0 9667.8 10062.6 10121.3 10298.5 9686.3 9885.6 9893.7 9984.5 9993.4 11:44:15 INFO - PROCESS | 1662 | -------- Summary: end -------- 11:44:15 INFO - PROCESS | 1662 | 11:44:16 INFO - TEST-INFO | 1662: exit 0 11:44:16 INFO - TEST-OK | dromaeo_css | took 1112697ms 11:44:16 INFO - TEST-START | kraken 11:44:16 INFO - operating with platform_type : mac_ 11:44:16 INFO - Initialising browser for kraken test... 11:44:16 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/tmp6stz4F/profile http://localhost:49274/getInfo.html) 11:44:18 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 11:44:18 INFO - PROCESS | 1673 | colorDepth:24 11:44:18 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 11:44:18 INFO - PROCESS | 1673 | __metrics 11:44:18 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" 11:44:18 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] 11:44:19 INFO - TEST-INFO | 1673: exit 0 11:44:19 INFO - Browser initialized. 11:44:19 INFO - Running cycle 1/1 for kraken test... 11:44:19 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/tmp6stz4F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:31 INFO - PROCESS | 1675 | RSS: Main: 210243584 11:44:31 INFO - PROCESS | 1675 | 11:44:33 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 11:44:34 INFO - PROCESS | 1675 | RSS: Main: 266014720 11:44:34 INFO - PROCESS | 1675 | 11:44:37 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 11:44:37 INFO - PROCESS | 1675 | RSS: Main: 275611648 11:44:37 INFO - PROCESS | 1675 | 11:44:40 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 11:44:41 INFO - PROCESS | 1675 | RSS: Main: 265129984 11:44:41 INFO - PROCESS | 1675 | 11:44:43 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 11:44:43 INFO - PROCESS | 1675 | RSS: Main: 266428416 11:44:43 INFO - PROCESS | 1675 | 11:44:45 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:46 INFO - PROCESS | 1675 | RSS: Main: 265474048 11:44:46 INFO - PROCESS | 1675 | 11:44:49 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:49 INFO - PROCESS | 1675 | RSS: Main: 267534336 11:44:49 INFO - PROCESS | 1675 | 11:44:52 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 11:44:53 INFO - PROCESS | 1675 | RSS: Main: 265740288 11:44:53 INFO - PROCESS | 1675 | 11:44:55 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 11:44:56 INFO - PROCESS | 1675 | RSS: Main: 267878400 11:44:56 INFO - PROCESS | 1675 | 11:44:58 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:44:58 INFO - PROCESS | 1675 | RSS: Main: 301035520 11:44:58 INFO - PROCESS | 1675 | 11:45:00 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:45:01 INFO - PROCESS | 1675 | RSS: Main: 301096960 11:45:01 INFO - PROCESS | 1675 | 11:45:03 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:45:03 INFO - PROCESS | 1675 | RSS: Main: 306278400 11:45:03 INFO - PROCESS | 1675 | 11:45:06 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:45:06 INFO - PROCESS | 1675 | RSS: Main: 308948992 11:45:06 INFO - PROCESS | 1675 | 11:45:09 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:45:09 INFO - PROCESS | 1675 | RSS: Main: 309092352 11:45:09 INFO - PROCESS | 1675 | 11:45:11 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 11:45:11 INFO - PROCESS | 1675 | RSS: Main: 368156672 11:45:11 INFO - PROCESS | 1675 | 11:45:11 INFO - PROCESS | 1675 | __start_tp_report 11:45:11 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 11:45:11 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 11:45:11 INFO - PROCESS | 1675 | |i|pagename|runs| 11:45:11 INFO - PROCESS | 1675 | |0;ai-astar;149;158;163;110;112;112;119;111;109;110 11:45:11 INFO - PROCESS | 1675 | |1;audio-beat-detection;155;120;139;165;142;168;136;115;161;113 11:45:11 INFO - PROCESS | 1675 | |2;audio-dft;184;182;185;185;184;182;183;182;183;183 11:45:11 INFO - PROCESS | 1675 | |3;audio-fft;81;73;71;116;55;57;58;57;115;55 11:45:11 INFO - PROCESS | 1675 | |4;audio-oscillator;89;96;127;80;77;89;118;76;81;115 11:45:11 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;86;83;85;82;86;83;85;83;86;83 11:45:11 INFO - PROCESS | 1675 | |6;imaging-darkroom;93;91;93;92;92;92;92;93;92;100 11:45:11 INFO - PROCESS | 1675 | |7;imaging-desaturate;84;87;87;86;86;85;84;84;84;104 11:45:11 INFO - PROCESS | 1675 | |8;json-parse-financial;56;58;57;56;57;58;59;67;53;51 11:45:11 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;66;61;72;74;69;65;70;66;66;67 11:45:11 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;80;82;81;80;78;80;79;78;80;83 11:45:11 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;130;129;115;116;115;121;126;121;124;122 11:45:11 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;133;120;132;131;132;139;166;167;129;133 11:45:11 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;67;65;66;66;67;64;89;67;65;66 11:45:11 INFO - PROCESS | 1675 | __end_tp_report 11:45:11 INFO - PROCESS | 1675 | __start_cc_report 11:45:11 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1189 11:45:11 INFO - PROCESS | 1675 | __end_cc_report 11:45:11 INFO - PROCESS | 1675 | __startTimestamp1458326711778__endTimestamp 11:45:11 INFO - PROCESS | 1675 | 11:45:11 INFO - PROCESS | 1675 | ------- Summary: start ------- 11:45:11 INFO - PROCESS | 1675 | Number of tests: 14 11:45:11 INFO - PROCESS | 1675 | 11:45:11 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:125.30 Median:115.50 stddev:22.07 (19.1%) stddev-sans-first:21.68 11:45:11 INFO - PROCESS | 1675 | Values: 149.0 158.0 163.0 110.0 112.0 112.0 119.0 111.0 109.0 110.0 11:45:11 INFO - PROCESS | 1675 | 11:45:11 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:148.50 stddev:20.63 (13.9%) stddev-sans-first:21.29 11:45:11 INFO - PROCESS | 1675 | Values: 155.0 120.0 139.0 165.0 142.0 168.0 136.0 115.0 161.0 113.0 11:45:11 INFO - PROCESS | 1675 | 11:45:11 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:183.30 Median:183.50 stddev:1.16 (0.6%) stddev-sans-first:1.20 11:45:11 INFO - PROCESS | 1675 | Values: 184.0 182.0 185.0 185.0 184.0 182.0 183.0 182.0 183.0 183.0 11:45:11 INFO - PROCESS | 1675 | 11:45:11 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:73.80 Median:57.50 stddev:23.71 (41.2%) stddev-sans-first:25.00 11:45:11 INFO - PROCESS | 1675 | Values: 81.0 73.0 71.0 116.0 55.0 57.0 58.0 57.0 115.0 55.0 11:45:11 INFO - PROCESS | 1675 | 11:45:11 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:80.50 stddev:18.65 (23.2%) stddev-sans-first:19.67 11:45:11 INFO - PROCESS | 1675 | Values: 89.0 96.0 127.0 80.0 77.0 89.0 118.0 76.0 81.0 115.0 11:45:11 INFO - PROCESS | 1675 | 11:45:11 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:84.20 Median:85.00 stddev:1.55 (1.8%) stddev-sans-first:1.50 11:45:11 INFO - PROCESS | 1675 | Values: 86.0 83.0 85.0 82.0 86.0 83.0 85.0 83.0 86.0 83.0 11:45:11 INFO - PROCESS | 1675 | 11:45:11 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:92.00 stddev:2.54 (2.8%) stddev-sans-first:2.69 11:45:11 INFO - PROCESS | 1675 | Values: 93.0 91.0 93.0 92.0 92.0 92.0 92.0 93.0 92.0 100.0 11:45:11 INFO - PROCESS | 1675 | 11:45:11 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:87.10 Median:85.50 stddev:6.06 (7.1%) stddev-sans-first:6.33 11:45:11 INFO - PROCESS | 1675 | Values: 84.0 87.0 87.0 86.0 86.0 85.0 84.0 84.0 84.0 104.0 11:45:11 INFO - PROCESS | 1675 | 11:45:11 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.50 stddev:4.21 (7.3%) stddev-sans-first:4.44 11:45:11 INFO - PROCESS | 1675 | Values: 56.0 58.0 57.0 56.0 57.0 58.0 59.0 67.0 53.0 51.0 11:45:11 INFO - PROCESS | 1675 | 11:45:11 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:3.75 (5.5%) stddev-sans-first:3.93 11:45:11 INFO - PROCESS | 1675 | Values: 66.0 61.0 72.0 74.0 69.0 65.0 70.0 66.0 66.0 67.0 11:45:11 INFO - PROCESS | 1675 | 11:45:11 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.00 stddev:1.60 (2.0%) stddev-sans-first:1.69 11:45:11 INFO - PROCESS | 1675 | Values: 80.0 82.0 81.0 80.0 78.0 80.0 79.0 78.0 80.0 83.0 11:45:11 INFO - PROCESS | 1675 | 11:45:11 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:123.00 stddev:5.47 (4.4%) stddev-sans-first:4.95 11:45:11 INFO - PROCESS | 1675 | Values: 130.0 129.0 115.0 116.0 115.0 121.0 126.0 121.0 124.0 122.0 11:45:11 INFO - PROCESS | 1675 | 11:45:11 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.20 Median:133.00 stddev:15.64 (11.8%) stddev-sans-first:16.48 11:45:11 INFO - PROCESS | 1675 | Values: 133.0 120.0 132.0 131.0 132.0 139.0 166.0 167.0 129.0 133.0 11:45:11 INFO - PROCESS | 1675 | 11:45:11 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:66.50 stddev:7.38 (11.1%) stddev-sans-first:7.81 11:45:11 INFO - PROCESS | 1675 | Values: 67.0 65.0 66.0 66.0 67.0 64.0 89.0 67.0 65.0 66.0 11:45:11 INFO - PROCESS | 1675 | -------- Summary: end -------- 11:45:11 INFO - PROCESS | 1675 | 11:45:12 INFO - TEST-INFO | 1675: exit 0 11:45:12 INFO - TEST-OK | kraken | took 56032ms 11:45:12 INFO - SUITE-END | took 1168s 11:45:12 INFO - Completed test suite (00:19:29) 11:45:12 INFO - javascript benchmark 11:45:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2747.0797282910225, 3491.7555771096036, 3504.456809194575, 3528.7882727036394, 3570.268095040517, 5721.313442386909, 5729.656220626765, 5732.168835518853, 5741.397153298895, 5764.250647415841, 5710.2862142232225, 5729.0, 5740.885182296352, 5755.568332375067, 5765.481106700396, 5118.616103792221, 5124.795008199668, 5155.793768249266, 5175.430702622709, 5189.636725429203, 5243.6853788772605, 5259.868503287429, 5261.210818377236, 5262.184361423985, 5271.710055946922, 5162.638615296931, 5169.095408303532, 5189.922151167735, 5207.114790485608, 5255.0, 5215.504527069922, 5263.36839579253, 5268.841934741964, 5272.815451459181, 5279.973600132013, 5005.57452616528, 5178.249153872667, 5183.326167598226, 5211.348581427322, 5222.712750798704, 5579.442055794429, 5630.408807075239, 5656.604037717361, 5657.519110875581, 5662.065759149736, 6182.474489668383, 6312.0, 6315.778947736807, 6325.367463253684, 6343.936560634381, 6191.133241346215, 6227.688615569204, 6243.906341404882, 6271.090691849702, 6271.749130034793, 5871.970640146772, 5873.500752436048, 5887.941120588825, 5932.406759324033, 5934.465898069108, 6214.0, 6272.905906411407, 6319.431251187323, 6322.462590679752, 6333.556651034383, 6228.377162283736, 6259.217597800275, 6262.812115636538, 6266.248050234001, 6268.435840774352, 6253.437190652863, 6265.404786545271, 6267.2165979252595, 6271.341509141565, 6276.717547710364, 6146.631202127886, 6187.969060154671, 6241.313455519889, 6284.025975973731, 6306.9684651576445, 6213.254409470893, 6233.657148856856, 6241.906371404432, 6250.968745156245, 6258.906116408258, 4899.118158731391, 4907.312976183337, 4919.0, 4923.064617722621, 4962.727050012284, 4390.121975604892, 4439.200943830077, 4466.151431228056, 4498.955010449854, 4512.503624601291, 5748.367679555246, 5814.680192589448, 5818.7672493100645, 5821.854453638693, 5841.386654401312, 6232.906506402317, 6252.0, 6254.6247225166635, 6256.405641464054, 6265.686715664289, 5695.658260504383, 5763.366029736726, 5771.509421699118, 5826.446487583673, 5836.708164591839, 5413.891722165535, 5420.593455490775, 5426.945730542644, 5428.185772134132, 5432.130859062531, 6359.7456101755415, 6364.968175159187, 6369.299377068519, 6370.394812492806, 6380.489560835122, 6178.567500274938, 6197.101420293942, 6225.128482012612, 6263.248410190807, 6269.749210031548, 6350.7459701611415, 6355.936440635534, 6358.078078678658, 6358.300586935526, 6372.808815735535, 6231.813045608639, 6234.407731265523, 6242.3133455320785, 6270.843228919313, 6272.278687950944, 5293.841184764463, 5733.455321744427, 6143.788236235041, 6240.188775459162, 6262.2172228471445, 6208.720607572761, 6221.564490485623, 6229.875402492015, 6235.46998505114, 6236.251649802053, 6179.907301390573, 6215.751369945332, 6239.220097487814, 6241.063840423973, 6252.187215661935, 5968.791092311748, 6036.396360363929, 6108.706347747117, 6124.5406594506485, 6131.754729810757, 5114.667546609458, 6201.441870231701, 6220.564560480904, 6228.968855155696, 6243.937560624336, 4931.2849636803185, 6105.877882442415, 6111.84720381994, 6116.847078823065, 6129.816105516842], "unit": "score", "name": "dojo.html", "value": 5728.117745933276}, {"lowerIsBetter": false, "replicates": [543.9936118181367, 593.9516752931074, 629.8425393651587, 660.2044536333718, 669.0098653992092, 39087.022824429405, 39402.21195576087, 39591.60408395915, 39607.99999999996, 39639.0, 42465.57534424662, 42965.925851853644, 42982.57017429825, 43145.56854431455, 43216.91957701059, 9621.855672164924, 9838.376667849832, 9849.753756156082, 9852.359596626233, 9854.359466634645, 8310.335173186131, 9576.0, 9742.025797420236, 9760.0, 9792.951035244849, 9776.657816976407, 9784.804303913954, 9821.459819709913, 9837.409755414697, 9840.95079524605, 8457.74626761195, 9815.754606134833, 9818.9509052455, 9845.45849978251, 9851.90148098517, 9743.171830394354, 9863.950680246624, 9870.851937220947, 9879.654212102541, 9884.95057524715, 41822.0, 42176.78911605453, 42190.0, 42205.0, 42219.15561688749, 2550.426154115328, 3051.969480305213, 3404.8934096418516, 3426.58880934287, 3494.248736521635, 28190.295242618893, 28236.85881570579, 28306.433871322664, 29315.973940911965, 29945.951891683904, 2775.9028434004713, 2820.9294767630972, 2850.700676428966, 2880.5967164596973, 2934.7652187824924, 362711.0, 363543.36456635623, 363694.0, 364579.0, 439791.0, 57537.712311438176, 58369.0, 58461.0, 75184.62407687926, 76427.23572764313, 72249.0, 72411.0, 72435.91346129813, 72825.0, 72846.0, 18733.531661708566, 18957.62084758297, 18958.905205473886, 18972.241110355706, 18984.810151898306, 14212.431502739775, 14304.141751494944, 14326.641833954234, 14491.20298383599, 14514.709705805824, 22541.211057612905, 22577.774222257896, 22617.434564136027, 22649.660255096187, 22734.886325568266, 9134.497602631918, 9308.627654893728, 9331.72004839856, 9336.393134446374, 9352.625894964125, 1019.3934608907688, 1067.9626213082504, 1100.983485247722, 1118.6755840806238, 1165.551262763825, 25589.744102559107, 29961.850190748908, 30153.396932061234, 30643.2339191522, 30648.846755766077, 932.5150921520772, 1049.9160067194607, 1149.179193284165, 1234.6789834642877, 1264.3109505319624, 12898.935505322414, 13743.793843092362, 14315.57053288403, 14952.551423457313, 14999.700006000037, 530740.0, 531055.0, 531624.0, 532266.0, 534949.0, 59442.70278648579, 60622.090668640005, 60728.69635651793, 60729.69635151884, 60923.0, 1414.0949792133042, 1441.5098866385479, 1444.1768192130594, 1532.1573134776052, 1560.5240401677597, 29453.410931781673, 29896.701032990262, 30194.0, 30718.539221911244, 30840.845795770878, 47612.0, 61058.38941610705, 62233.68883155737, 62272.06591901216, 62286.0, 372942.1352893218, 378396.0, 381036.0, 381436.0, 382187.0, 30830.0, 33757.0, 33823.0, 34707.0, 34903.30193396067, 45234.869128272054, 46204.53795462002, 46556.7672161637, 47313.29030064621, 48218.0, 38609.80695096507, 38661.80669096637, 38957.415638764876, 39391.0, 39449.80275098606, 38606.6139338603, 38721.80639096787, 38737.418938715375, 38751.22497549977, 39611.0, 33337.666623333454, 33827.0, 34104.48843267303, 34627.48058779171, 34697.479537807456, 32460.51309230316, 32481.837590811894, 32908.67091329056, 33037.0, 33253.0, 24927.750722492543, 25000.249992500256, 25027.249182524552, 25551.612096975758, 25554.872225638752], "unit": "score", "name": "ext.html", "value": 20279.78857488458}, {"lowerIsBetter": false, "replicates": [341.25435922509337, 384.85375557288233, 389.83432041382406, 392.758453551066, 396.3123979894882, 15620.609484762886, 20513.897430512847, 20714.689279660815, 21063.578728425422, 21232.893835530802, 20597.279095231668, 20728.27451039214, 21357.786422135774, 21393.46516337092, 21408.678869816966, 5759.510441612458, 5950.761969521214, 5999.0, 6000.519958403317, 6020.367861374536, 5675.574331925101, 5897.941020589804, 5912.704364781765, 5926.170336152942, 5934.43622855828, 5833.7083145842535, 5858.5606079543995, 5863.824085277449, 5871.853203669921, 5878.118282257674, 5604.775808967657, 5746.48281654651, 5775.826725198251, 5794.130880367937, 5830.300363956331, 5019.29729837823, 5045.520675535819, 5050.0, 5052.621053420971, 5076.111680455942, 25782.742172578222, 26190.73809261902, 26512.734872651414, 26542.336441588923, 26572.601410978852, 2241.7085778848646, 2292.1862738727677, 2321.570509455756, 2636.934076648099, 2653.3499292673228, 9838.163756080741, 10540.472976351228, 15070.397184112622, 15665.29506172225, 16382.918085409498, 1806.1240298455239, 1806.7470554122433, 1854.2582966813247, 1857.071464267866, 1878.0, 102329.48835255776, 103213.48393258061, 104946.0, 107277.85444291148, 110778.0, 11648.88351116478, 11869.525218991144, 11904.404779760976, 11917.940410297893, 11983.760324793455, 13168.275744833934, 13358.732825343634, 14497.565073047825, 14500.854991450162, 14515.274236288144, 9154.176124148726, 9160.587773550205, 9204.723858284262, 9223.10926260115, 9274.30442716799, 9438.95280523593, 9439.150476457151, 9500.619975200914, 9580.66467673628, 9624.470654114091, 4593.908121837545, 4675.13510000651, 4680.836170734008, 4726.976365118152, 4732.337472753818, 1946.6593346164364, 1954.7654281486314, 1957.9216831326871, 1959.9970258011692, 1989.9005049747454, 924.3390975452584, 985.3348989432104, 991.7768502086973, 999.6601155607128, 1011.5144730529387, 20571.794282057286, 20849.0, 20903.895480522806, 21103.894480527808, 21171.47071323229, 986.5954958466995, 1026.5329275179774, 1073.9677809665723, 1079.83262594298, 1092.792369449802, 8787.692430764893, 11190.104791616652, 11210.21528493014, 11210.495527701272, 11287.774244515227, 531122.0, 632087.0, 637739.0, 653275.0, 653728.0, 113826.4308678468, 119214.0, 119321.40339298421, 121483.78516214901, 121791.0, 1070.925035247525, 1080.1574771677947, 1118.072000239799, 1138.8064029115071, 1140.2246472398683, 18009.337587013153, 18163.27346906109, 18493.630127397646, 18557.628847423246, 18656.0, 50419.487415377596, 51693.48306516887, 51742.74128629333, 51893.7405312971, 52091.0, 70992.64503677448, 72198.63900680463, 72820.63589682018, 73960.63019684867, 75585.0, 6342.0, 8360.87458688108, 8498.362622803437, 8544.40189186751, 8801.29589632815, 12739.681507962376, 13134.343282835629, 13421.932890335485, 13453.192808431526, 13855.0, 5704.857378565403, 8964.955175224082, 11563.364014979257, 11693.0, 11902.809719028028, 11675.416229188677, 11734.239943535598, 11768.470418831002, 11845.466953987263, 12174.57388991381, 11903.16677832578, 12040.397980100784, 12101.0, 12255.142140050111, 12422.130450868352, 8415.663373464993, 8552.57237138153, 8644.00593931706, 8686.684383800703, 8698.0, 8726.65093396257, 9179.862302065609, 11070.557177713123, 11793.0, 11993.220440671328], "unit": "score", "name": "jquery.html", "value": 9746.537112224914}, {"lowerIsBetter": false, "replicates": [1513.296317212496, 1534.7084054029733, 1680.7646929429882, 2000.6098810731903, 2100.590384874948, 8477.78805529862, 9137.543122843856, 9280.582373793179, 9288.767780805483, 9293.442393456397, 8876.15676510732, 9154.450732956027, 9165.725028249146, 9166.908330916689, 9171.449713017208, 2171.185805323004, 2591.922242332733, 2596.31197732601, 2598.22053383985, 2601.557735185023, 2527.064985955199, 2610.0, 2611.0861198580533, 2616.0, 2626.5928781038874, 2594.377349436131, 2612.4122072533623, 2632.2629663694197, 2632.473505298938, 2637.3670319123366, 2592.64999225105, 2595.9480810383875, 2616.5028644557474, 2627.1067836935536, 2631.5657916443765, 2436.84160529565, 2575.3304140923306, 2602.2323414592743, 2623.9868800656063, 2626.684797824254, 9357.39176953496, 9411.917629472562, 9419.293552983485, 9424.434533927986, 9434.622615095388, 5628.971855140698, 5811.564132690023, 5858.41415858415, 5867.8533036674, 5881.67650779207, 3750.13746838226, 3826.4451654510217, 3843.3466310727244, 3871.845126194949, 3875.302445559798, 1065.6323568368978, 1079.4602698650674, 1085.4084523934475, 1099.4228030284085, 1126.8704099028635, 12668.36658167088, 12672.23966562, 12679.239245645198, 12724.982001439863, 12730.427130779137, 5039.118154322979, 5047.192449208109, 5120.462351453119, 5141.794328226829, 5163.586913046947, 10779.137668986463, 10818.24272300947, 10820.891791082146, 10821.0, 10834.133269338434, 5697.6296540724725, 5738.741756620962, 5753.712314384264, 5754.136879468029, 5759.884802303931, 4636.698614590108, 4811.965427433119, 4997.825076122318, 5178.818741344035, 5190.403103643054, 4106.244230711946, 4164.979175104166, 4173.640219623232, 4211.7472951623, 4222.662187025031, 1341.7920222365549, 1364.87716105549, 1365.8907287416982, 1373.0, 1375.113052081402, 1085.4138765066934, 1100.625787232345, 1207.0705556721275, 1223.5044806853239, 1365.3173413293352, 8278.71024514139, 8332.791680207922, 8379.329653627696, 8381.329493640495, 8383.03595086573, 1257.1074537078593, 1263.128441375448, 1265.1776345375395, 1290.3548225887057, 1302.4139137388213, 6216.564840461125, 6278.30938596754, 6319.905201421982, 6325.335839736761, 6339.651319177489, 11042.0, 11279.32324060559, 11439.828402573969, 11582.36297003656, 11691.473883675255, 11334.886651133384, 11386.0, 11425.828612570818, 11518.308901465938, 11540.942295288638, 8362.289205417608, 8545.529995850164, 8752.956235218782, 8762.518061506551, 8817.823643527221, 8409.990801103906, 8419.8737018946, 8421.831563368822, 8484.490930544187, 8527.445716028438, 9774.560144793359, 9912.35569687968, 10018.849717254392, 10072.496375181358, 10191.796164076824, 10116.696499105039, 10446.895531044896, 10459.581616735246, 10469.26715129964, 10617.203709721956, 7210.206877243394, 7642.312191902755, 7957.204279571996, 7992.240737129963, 8121.9593902032475, 8634.697785577475, 8636.827263454821, 8704.042555318783, 8712.91287087121, 8719.564021799011, 7185.958036084843, 7573.886391704019, 7770.572618506037, 7916.406269529693, 8078.0, 5616.354119276336, 7143.464240182111, 7507.962460187664, 7604.885926711215, 7738.458307918391, 8002.239787220205, 8157.0, 8162.591870406574, 8166.265036146538, 8169.428140030141, 7265.346118849329, 7354.338109570164, 7370.852582948418, 7372.741954031798, 7379.077615298088, 7470.3276705096805, 7496.025516683015, 7497.175310715707, 7497.437692173218, 7504.474686771873], "unit": "score", "name": "mootools.html", "value": 5195.959641439004}, {"lowerIsBetter": false, "replicates": [341.45878782130325, 347.51521627329873, 350.33960983546007, 352.2321339479934, 354.9183687751817, 6624.403803657676, 6636.60180389177, 6669.833254168649, 6683.632400217992, 6742.528023038377, 6610.933890661092, 6636.104125942997, 6637.834054148649, 6651.966740166293, 6654.168228971379, 4707.741074240916, 4777.187878060738, 4783.258594917794, 4871.050145221683, 4956.083124621957, 4880.9755951220195, 4898.265260210979, 4911.5088491150955, 4939.234418665094, 4953.678010929296, 4881.267809828536, 4885.755712214393, 4893.755312234392, 4903.117438861003, 4914.32169467641, 4635.745034023127, 4724.622030237607, 4746.881327966794, 4749.121412538691, 4847.030593881203, 4185.351270553069, 4192.5807419258135, 4206.41110244566, 4225.492940847118, 4227.91544169118, 6259.998400255983, 6348.396902294275, 6361.268454127789, 6361.300256971729, 6393.168888044571, 5889.057750759901, 5892.911606325909, 5902.291724992985, 5906.734196961104, 5918.40815918409, 6838.863222735517, 7097.92902070983, 7106.324899134574, 7119.53723008008, 7128.144622645264, 4789.137955168068, 4826.734529600871, 4832.613390928717, 4837.927431088537, 4838.830640927586, 7433.442491813082, 7509.0989081310045, 7509.211532789033, 7510.549367037941, 7516.248375162495, 4933.186024305949, 4938.259261110862, 4939.333190019373, 4949.48030456804, 4951.306817045616, 4990.155611301523, 5000.799968001239, 5021.020900924358, 5021.096202683552, 5027.120253955543, 5684.204211410323, 5918.556108291896, 5919.467247947706, 5923.141144534018, 5929.169916211734, 7097.787066388017, 7125.821854453577, 7126.536775109601, 7129.429645628441, 7132.643367831588, 1727.8337122442301, 1754.877158598886, 1757.5693954981111, 1758.5867321179512, 1759.0501129389986, 1146.5070019891527, 1148.8506494155706, 1161.5702190189684, 1174.518447436547, 1178.664080737003, 5772.701142242961, 6082.543809214327, 6583.637899915455, 6588.24235212947, 6588.604683718992, 6824.624645644438, 6833.829154271183, 7324.67038983247, 7494.587797671072, 7500.512466689757, 5671.291088613923, 6552.148220731275, 6691.130153080068, 6697.966510167418, 6700.430463410665, 3887.455756194135, 3931.724779265481, 3937.2322397132284, 3940.724149309578, 3944.487216661873, 6348.04779283102, 6517.576357536745, 6633.668316584151, 7501.0291494325365, 7729.922700773032, 7645.426593005547, 7690.423218258653, 7695.115061767857, 7696.538207707556, 7700.306972372513, 7703.422243331885, 7704.229577042363, 7708.691652333844, 7713.4600577959, 7722.189170137167, 7406.259374062766, 7426.4430167736555, 7439.293267139613, 7444.702211911463, 7452.0, 7001.5799052055, 7309.232530584425, 7349.154847192642, 7351.228121047213, 7358.22738612438, 7684.807879802826, 7737.3036426721865, 7779.066512018594, 7783.377329813488, 7789.143194248515, 4725.976370118127, 4772.427308722976, 4772.665913386029, 4782.306565547907, 4788.3056956741775, 7428.1086269647985, 7435.442341824277, 7437.367823735043, 7437.367823735043, 7451.217622149813, 6850.862982740417, 7142.285771422816, 7174.533655312388, 7198.6400679964745, 7200.135983681992, 6073.605215660968, 6935.549189302679, 7181.569105853666, 7184.856302873809, 7189.676464559003, 6992.056072430157, 7008.859822803617, 7016.5088443808445, 7025.402840758593, 7028.929710702828, 6927.238003819677, 7138.500304978602, 7143.357097861218, 7160.391366733886, 7163.140423149047, 6699.8325041872395, 6846.315368463114, 6849.075374824335, 7039.260877607778, 7044.15470143586], "unit": "score", "name": "prototype.html", "value": 5253.817561135938}, {"lowerIsBetter": false, "replicates": [731.2943009995354, 752.2477522477519, 793.1592511937343, 800.0, 805.110353059869, 15086.245687715611, 15409.46066887659, 15412.152331621757, 15420.691586168285, 15456.69086618267, 14499.0, 14524.3464044118, 15293.464728734496, 16387.91806040968, 16398.016119032865, 969.7187815533487, 980.3039841712392, 995.4027583449945, 995.4674249276638, 996.0238965813508, 988.5008070924173, 989.213575207708, 993.6869885985927, 994.3337963564429, 996.875390576178, 1048.5491238767327, 1050.4642632257528, 1055.2191378379982, 1058.0636137018755, 1058.7935352606246, 1039.9376037437778, 1040.7242080848582, 1041.6822869024945, 1042.8331466965249, 1044.8380501022355, 781.9022622172229, 782.8669126248494, 783.7844592737043, 785.9174786647434, 787.189195129018, 14967.550973470814, 15191.544253672408, 15275.465358712392, 15429.151396673178, 15466.45867394647, 12953.158044727063, 13122.60632181036, 13138.802917956238, 13369.933150334284, 13449.313820622976, 10091.79816403675, 10133.594656213743, 10316.742081447948, 10446.791064178673, 10624.681259562225, 3583.157957879896, 3604.4232922732235, 3658.560972683295, 3676.5220521332058, 3819.4652748615217, 66694.6661066776, 72219.63890180516, 81910.18089819085, 82203.0, 82328.3534329316, 9569.712908612753, 9595.944446110921, 9609.375390599589, 9838.260791357943, 9853.014698530089, 22932.541349172923, 22984.4253893654, 22991.08035678554, 23005.96473158712, 23007.194748183734, 7580.393568514505, 7628.8474230516185, 7708.9229107709325, 7826.530408175414, 7869.0, 4124.566920473367, 4186.91626167475, 4257.40396344512, 4298.376735373354, 4460.531644177379, 3677.5219221501034, 3712.053426376257, 3728.5712143103347, 3735.5143831301757, 3741.0273328934127, 640.961542307463, 647.1134545672459, 659.041095206483, 660.4287291492824, 663.3333499832734, 597.8027251007157, 615.3262177915176, 625.6558892609047, 627.159606127791, 635.4789072960128, 8208.630611622491, 8255.793605159919, 8411.621477033548, 8506.064332923374, 8750.168733970262, 595.8897603943284, 602.629382929504, 608.1850320570456, 639.9808005759835, 642.1651852591613, 2981.3142977114953, 3591.7665351752053, 3609.242059167604, 3938.487996560486, 4144.564820693844, 91340.54329728309, 96940.54589181168, 97887.0, 98946.0, 99509.50245248727, 72719.0, 83136.0, 83993.0, 84354.5782271097, 85466.14533854707, 73263.0, 73627.52744945072, 74402.13994650177, 76052.0, 76052.61973690207, 8667.219950204511, 8731.476111433334, 8796.164364385373, 8980.730578082668, 9006.0, 49995.0, 52524.474755251955, 52774.73612631912, 54114.0, 54763.0, 70738.0, 75649.24350756421, 75951.0, 76844.61577692076, 78394.6080269595, 11191.0, 11501.654950351503, 11513.769724605294, 11562.691919092103, 11608.767824643292, 10139.7465063374, 11964.0, 12070.698232544257, 12426.502939882303, 12574.30841303737, 11411.429428528707, 11612.187146899636, 11641.6507504775, 11706.063514918616, 11873.762524749629, 11691.883081169079, 11828.763424731285, 11975.580854670045, 12013.459394327101, 12049.096317776026, 11438.08495320389, 11480.655580332603, 11612.187146899636, 11618.535258589562, 12227.0, 9574.036109378017, 9667.81759733297, 10062.647807326708, 10121.291509594552, 10298.485075746332, 9686.321957463191, 9885.604575817175, 9893.703188904057, 9984.500774961369, 9993.400395975974], "unit": "score", "name": "yui.html", "value": 7236.751759686933}], "name": "dromaeo_css", "value": 7791.252654336054}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [149.0, 158.0, 163.0, 110.0, 112.0, 112.0, 119.0, 111.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 125.3}, {"lowerIsBetter": true, "replicates": [155.0, 120.0, 139.0, 165.0, 142.0, 168.0, 136.0, 115.0, 161.0, 113.0], "unit": "score", "name": "audio-beat-detection", "value": 141.4}, {"lowerIsBetter": true, "replicates": [184.0, 182.0, 185.0, 185.0, 184.0, 182.0, 183.0, 182.0, 183.0, 183.0], "unit": "score", "name": "audio-dft", "value": 183.3}, {"lowerIsBetter": true, "replicates": [81.0, 73.0, 71.0, 116.0, 55.0, 57.0, 58.0, 57.0, 115.0, 55.0], "unit": "score", "name": "audio-fft", "value": 73.8}, {"lowerIsBetter": true, "replicates": [89.0, 96.0, 127.0, 80.0, 77.0, 89.0, 118.0, 76.0, 81.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 94.8}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 85.0, 82.0, 86.0, 83.0, 85.0, 83.0, 86.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 84.2}, {"lowerIsBetter": true, "replicates": [93.0, 91.0, 93.0, 92.0, 92.0, 92.0, 92.0, 93.0, 92.0, 100.0], "unit": "score", "name": "imaging-darkroom", "value": 93.0}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 87.0, 86.0, 86.0, 85.0, 84.0, 84.0, 84.0, 104.0], "unit": "score", "name": "imaging-desaturate", "value": 87.1}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 57.0, 56.0, 57.0, 58.0, 59.0, 67.0, 53.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [66.0, 61.0, 72.0, 74.0, 69.0, 65.0, 70.0, 66.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 81.0, 80.0, 78.0, 80.0, 79.0, 78.0, 80.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.1}, {"lowerIsBetter": true, "replicates": [130.0, 129.0, 115.0, 116.0, 115.0, 121.0, 126.0, 121.0, 124.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.9}, {"lowerIsBetter": true, "replicates": [133.0, 120.0, 132.0, 131.0, 132.0, 139.0, 166.0, 167.0, 129.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.2}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 66.0, 66.0, 67.0, 64.0, 89.0, 67.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1416.1000000000001}]} 11:45:13 INFO - Return code: 0 11:45:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:45:13 INFO - # TBPL SUCCESS # 11:45:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:45:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:45:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:45:13 INFO - 2016-03-18 11:45:13.107 screenresolution[1679:10042] starting screenresolution argv=screenresolution get 11:45:13 INFO - 2016-03-18 11:45:13.110 screenresolution[1679:10042] Display 0: 1600x1200x32@60 11:45:13 INFO - 2016-03-18 11:45:13.115 screenresolution[1680:10045] starting screenresolution argv=screenresolution list 11:45:13 INFO - Available Modes on Display 0 11:45:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:45:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:45:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:45:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:45:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:45:13 INFO - Intel Iris: 11:45:13 INFO - Chipset Model: Intel Iris 11:45:13 INFO - Type: GPU 11:45:13 INFO - Bus: Built-In 11:45:13 INFO - VRAM (Dynamic, Max): 1536 MB 11:45:13 INFO - Vendor: Intel (0x8086) 11:45:13 INFO - Device ID: 0x0a2e 11:45:13 INFO - Revision ID: 0x0009 11:45:13 INFO - Displays: 11:45:13 INFO - Display: 11:45:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:45:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:45:13 INFO - Display Serial Number: 1600x1200 60 11:45:13 INFO - Main Display: Yes 11:45:13 INFO - Mirror: Off 11:45:13 INFO - Online: Yes 11:45:13 INFO - Rotation: Supported 11:45:13 INFO - Return code: 0 11:45:13 INFO - Running post-action listener: _resource_record_post_action 11:45:13 INFO - Running post-run listener: _resource_record_post_run 11:45:14 INFO - Total resource usage - Wall time: 1203s; CPU: 52.0%; Read bytes: 37361152; Write bytes: 664669184; Read time: 426; Write time: 2629 11:45:14 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 358115840; Write bytes: 353527808; Read time: 28079; Write time: 683 11:45:14 INFO - run-tests - Wall time: 1171s; CPU: 52.0%; Read bytes: 35558912; Write bytes: 299967488; Read time: 405; Write time: 1912 11:45:14 INFO - Running post-run listener: _upload_blobber_files 11:45:14 INFO - Blob upload gear active. 11:45:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:45:14 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 11:45:14 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'] 11:45:14 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 11:45:14 INFO - (blobuploader) - INFO - Open directory for files ... 11:45:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:45:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:45:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:15 INFO - (blobuploader) - INFO - Done attempting. 11:45:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:45:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:45:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:16 INFO - (blobuploader) - INFO - Done attempting. 11:45:16 INFO - (blobuploader) - INFO - Iteration through files over. 11:45:16 INFO - Return code: 0 11:45:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:45:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:45:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f402204e77350a183a51f41d9f6bfd8de274f013e0b206b03222439442f38d44f860aeda54d0674b449296bbe451c9e7209d8b7f3e0ff8b1aef88962f59f5362", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/94f599b93f31e1fb168a6b41418847cd8e534e6d6b063af1cd91472d3e9e6ed50df71afbdda15a2833ec167af3af6b92b924312c16c4a6679b48fa2ef60b74cc"} 11:45:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:45:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:45:16 INFO - Contents: 11:45:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f402204e77350a183a51f41d9f6bfd8de274f013e0b206b03222439442f38d44f860aeda54d0674b449296bbe451c9e7209d8b7f3e0ff8b1aef88962f59f5362", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/94f599b93f31e1fb168a6b41418847cd8e534e6d6b063af1cd91472d3e9e6ed50df71afbdda15a2833ec167af3af6b92b924312c16c4a6679b48fa2ef60b74cc"} 11:45:16 INFO - Running post-run listener: copy_logs_to_upload_dir 11:45:16 INFO - Copying logs to upload dir... 11:45:16 INFO - mkdir: /builds/slave/test/build/upload/logs 11:45:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.720650 ========= master_lag: 3.57 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-03-18 11:45:20.297194) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 17 secs) (at 2016-03-18 11:45:20.305508) ========= 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.7AKQu0qvoP/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.FdG1EuSS5D/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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/f402204e77350a183a51f41d9f6bfd8de274f013e0b206b03222439442f38d44f860aeda54d0674b449296bbe451c9e7209d8b7f3e0ff8b1aef88962f59f5362", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/94f599b93f31e1fb168a6b41418847cd8e534e6d6b063af1cd91472d3e9e6ed50df71afbdda15a2833ec167af3af6b92b924312c16c4a6679b48fa2ef60b74cc"} build_url:https://queue.taskcluster.net/v1/task/P5cezEc_TfuG9sa4gmb0zg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011400 build_url: 'https://queue.taskcluster.net/v1/task/P5cezEc_TfuG9sa4gmb0zg/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/f402204e77350a183a51f41d9f6bfd8de274f013e0b206b03222439442f38d44f860aeda54d0674b449296bbe451c9e7209d8b7f3e0ff8b1aef88962f59f5362", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/94f599b93f31e1fb168a6b41418847cd8e534e6d6b063af1cd91472d3e9e6ed50df71afbdda15a2833ec167af3af6b92b924312c16c4a6679b48fa2ef60b74cc"}' ========= master_lag: 17.11 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 17 secs) (at 2016-03-18 11:45:37.424228) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-03-18 11:45:37.424605) ========= 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.7AKQu0qvoP/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.FdG1EuSS5D/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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.005497 ========= master_lag: 3.26 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-03-18 11:45:40.690745) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-03-18 11:45:40.691057) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-03-18 11:45:42.068106) ========= ========= Total master_lag: 24.49 =========