builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0187 starttime: 1457430497.49 results: success (0) buildid: 20160307110830 builduid: 3d893880bf6946649cd91a0559a56e1e revision: a06ac8e3220a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:17.486222) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:17.486601) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:17.486896) ========= 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.MEHc2FmTVZ/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.6sXRocbcx7/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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.005943 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:17.517448) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:17.517738) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:17.536306) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:17.536577) ========= 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.MEHc2FmTVZ/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.6sXRocbcx7/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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.005434 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:17.584130) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:17.584411) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:17.587695) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:17.588000) ========= 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.MEHc2FmTVZ/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.6sXRocbcx7/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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-08 01:48:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.2M=0.001s 2016-03-08 01:48:17 (15.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.220757 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:17.825135) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:17.825442) ========= 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.MEHc2FmTVZ/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.6sXRocbcx7/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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.026997 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:17.876218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-08 01:48:17.876554) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a06ac8e3220a --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 a06ac8e3220a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MEHc2FmTVZ/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.6sXRocbcx7/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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-08 01:48:17,955 Setting DEBUG logging. 2016-03-08 01:48:17,955 attempt 1/10 2016-03-08 01:48:17,955 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a06ac8e3220a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-08 01:48:19,590 unpacking tar archive at: mozilla-aurora-a06ac8e3220a/testing/mozharness/ program finished with exit code 0 elapsedTime=2.465825 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-08 01:48:20.363927) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:20.364281) ========= echo a06ac8e3220a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a06ac8e3220a'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MEHc2FmTVZ/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.6sXRocbcx7/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 a06ac8e3220a program finished with exit code 0 elapsedTime=0.005545 script_repo_revision: 'a06ac8e3220a' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:20.416073) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:20.416366) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:20.435390) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-03-08 01:48:20.435680) ========= /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.MEHc2FmTVZ/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.6sXRocbcx7/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 01:48:20 INFO - MultiFileLogger online at 20160308 01:48:20 in /builds/slave/test 01:48:20 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 01:48:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:48:20 INFO - {'append_to_log': False, 01:48:20 INFO - 'base_work_dir': '/builds/slave/test', 01:48:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:48:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:48:20 INFO - 'branch': 'Mozilla-Aurora', 01:48:20 INFO - 'buildbot_json_path': 'buildprops.json', 01:48:20 INFO - 'config_files': ('talos/mac_config.py',), 01:48:20 INFO - 'default_actions': ('clobber', 01:48:20 INFO - 'read-buildbot-config', 01:48:20 INFO - 'download-and-extract', 01:48:20 INFO - 'populate-webroot', 01:48:20 INFO - 'create-virtualenv', 01:48:20 INFO - 'install', 01:48:20 INFO - 'run-tests'), 01:48:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:48:20 INFO - 'download_minidump_stackwalk': True, 01:48:20 INFO - 'download_symbols': 'ondemand', 01:48:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:48:20 INFO - 'tooltool.py': '/tools/tooltool.py', 01:48:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:48:20 INFO - '/tools/misc-python/virtualenv.py')}, 01:48:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:48:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:48:20 INFO - 'installer_path': 'installer.exe', 01:48:20 INFO - 'log_level': 'info', 01:48:20 INFO - 'log_name': 'talos', 01:48:20 INFO - 'log_to_console': True, 01:48:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:48:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:48:20 INFO - 'opt_config_files': (), 01:48:20 INFO - 'pip_index': False, 01:48:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:48:20 INFO - 'cmd': ('bash', 01:48:20 INFO - '-c', 01:48:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:48:20 INFO - 'enabled': True, 01:48:20 INFO - 'halt_on_failure': False, 01:48:20 INFO - 'name': 'check_screen_resolution'},), 01:48:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:48:20 INFO - 'cmd': ('bash', 01:48:20 INFO - '-c', 01:48:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:48:20 INFO - 'enabled': True, 01:48:20 INFO - 'halt_on_failure': False, 01:48:20 INFO - 'name': 'check_screen_resolution'},), 01:48:20 INFO - 'run_cmd_checks_enabled': True, 01:48:20 INFO - 'sps_profile': False, 01:48:20 INFO - 'sps_profile_interval': 0, 01:48:20 INFO - 'suite': 'dromaeojs', 01:48:20 INFO - 'system_bits': '32', 01:48:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:48:20 INFO - 'title': 't-yosemite-r7-0187', 01:48:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:48:20 INFO - 'use_talos_json': True, 01:48:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:48:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:48:20 INFO - 'work_dir': 'build'} 01:48:20 INFO - ##### 01:48:20 INFO - ##### Running clobber step. 01:48:20 INFO - ##### 01:48:20 INFO - Running pre-action listener: _resource_record_pre_action 01:48:20 INFO - Running main action method: clobber 01:48:20 INFO - rmtree: /builds/slave/test/build 01:48:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:48:22 INFO - Running post-action listener: _resource_record_post_action 01:48:22 INFO - ##### 01:48:22 INFO - ##### Running read-buildbot-config step. 01:48:22 INFO - ##### 01:48:22 INFO - Running pre-action listener: _resource_record_pre_action 01:48:22 INFO - Running main action method: read_buildbot_config 01:48:22 INFO - Using buildbot properties: 01:48:22 INFO - { 01:48:22 INFO - "project": "", 01:48:22 INFO - "product": "firefox", 01:48:22 INFO - "script_repo_revision": "production", 01:48:22 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 01:48:22 INFO - "repository": "", 01:48:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 01:48:22 INFO - "buildid": "20160307110830", 01:48:22 INFO - "pgo_build": "False", 01:48:22 INFO - "basedir": "/builds/slave/test", 01:48:22 INFO - "buildnumber": 203, 01:48:22 INFO - "slavename": "t-yosemite-r7-0187", 01:48:22 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 01:48:22 INFO - "platform": "yosemite_r7", 01:48:22 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 01:48:22 INFO - "branch": "mozilla-aurora", 01:48:22 INFO - "repo_path": "releases/mozilla-aurora", 01:48:22 INFO - "revision": "a06ac8e3220a", 01:48:22 INFO - "stage_platform": "macosx64", 01:48:22 INFO - "builduid": "3d893880bf6946649cd91a0559a56e1e", 01:48:22 INFO - "slavebuilddir": "test" 01:48:22 INFO - } 01:48:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 01:48:22 INFO - Running post-action listener: _resource_record_post_action 01:48:22 INFO - ##### 01:48:22 INFO - ##### Running download-and-extract step. 01:48:22 INFO - ##### 01:48:22 INFO - Running pre-action listener: _resource_record_pre_action 01:48:22 INFO - Running main action method: download_and_extract 01:48:22 INFO - mkdir: /builds/slave/test/build/tests 01:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:22 INFO - https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:48:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 01:48:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 01:48:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 01:48:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 01:48:24 INFO - Downloaded 1277 bytes. 01:48:24 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 01:48:24 INFO - Using the following test package requirements: 01:48:24 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:48:24 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:48:24 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 01:48:24 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:48:24 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 01:48:24 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:48:24 INFO - u'jsshell-mac.zip'], 01:48:24 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:48:24 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 01:48:24 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:48:24 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:48:24 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 01:48:24 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:48:24 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 01:48:24 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:48:24 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 01:48:24 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:48:24 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:48:24 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 01:48:24 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:48:24 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')]} 01:48:24 INFO - https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:48:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:48:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:48:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:48:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:48:25 INFO - Downloaded 17859094 bytes. 01:48:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:48:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:48:28 INFO - Return code: 0 01:48:28 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 01:48: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')]} 01:48:28 INFO - https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:48:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:48:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:48:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:48:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:48:36 INFO - Downloaded 17859094 bytes. 01:48:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:48:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:48:39 INFO - Return code: 0 01:48: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')]} 01:48:39 INFO - https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:48:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:48:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:48:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:48:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 01:48:41 INFO - Downloaded 10803659 bytes. 01:48:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:48:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 01:48:41 INFO - Return code: 0 01:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:41 INFO - https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:48:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:48:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:48:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 01:48:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 01:48:46 INFO - Downloaded 110928407 bytes. 01:48:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:48:46 INFO - mkdir: /builds/slave/test/properties 01:48:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:48:46 INFO - Writing to file /builds/slave/test/properties/build_url 01:48:46 INFO - Contents: 01:48:46 INFO - build_url:https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:48:47 INFO - Running post-action listener: _resource_record_post_action 01:48:47 INFO - Running post-action listener: set_extra_try_arguments 01:48:47 INFO - ##### 01:48:47 INFO - ##### Running populate-webroot step. 01:48:47 INFO - ##### 01:48:47 INFO - Running pre-action listener: _resource_record_pre_action 01:48:47 INFO - Running main action method: populate_webroot 01:48:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:48:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:48:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:48:47 INFO - '--tppagecycles', 01:48:47 INFO - '7'], 01:48:47 INFO - 'tests': ['tsvgm']}}, 01:48:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:48:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:48:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:48:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:48:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:48:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:48:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:48:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:47 INFO - 'talos_options': ['--e10s'], 01:48:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:48:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:47 INFO - 'tests': ['damp', 'tps']}, 01:48:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:47 INFO - 'talos_options': ['--e10s'], 01:48:47 INFO - 'tests': ['damp', 'tps']}, 01:48:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:48:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:48:47 INFO - 'other': {'tests': ['a11yr', 01:48:47 INFO - 'ts_paint', 01:48:47 INFO - 'tpaint', 01:48:47 INFO - 'sessionrestore', 01:48:47 INFO - 'sessionrestore_no_auto_restore']}, 01:48:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:48:47 INFO - 'tests': ['a11yr', 01:48:47 INFO - 'ts_paint', 01:48:47 INFO - 'tpaint', 01:48:47 INFO - 'sessionrestore', 01:48:47 INFO - 'sessionrestore_no_auto_restore']}, 01:48:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:48:47 INFO - 'tests': ['a11yr', 01:48:47 INFO - 'ts_paint', 01:48:47 INFO - 'tpaint', 01:48:47 INFO - 'sessionrestore', 01:48:47 INFO - 'sessionrestore_no_auto_restore']}, 01:48:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:48:47 INFO - 'tests': ['a11yr', 01:48:47 INFO - 'ts_paint', 01:48:47 INFO - 'tpaint', 01:48:47 INFO - 'sessionrestore', 01:48:47 INFO - 'sessionrestore_no_auto_restore']}, 01:48:47 INFO - 'other_l64': {'tests': ['a11yr', 01:48:47 INFO - 'ts_paint', 01:48:47 INFO - 'tpaint', 01:48:47 INFO - 'sessionrestore', 01:48:47 INFO - 'sessionrestore_no_auto_restore']}, 01:48:47 INFO - 'other_nol64': {'tests': ['a11yr', 01:48:47 INFO - 'ts_paint', 01:48:47 INFO - 'tpaint', 01:48:47 INFO - 'sessionrestore', 01:48:47 INFO - 'sessionrestore_no_auto_restore']}, 01:48:47 INFO - 'svgr': {'tests': ['tsvgx', 01:48:47 INFO - 'tsvgr_opacity', 01:48:47 INFO - 'tart', 01:48:47 INFO - 'tscrollx', 01:48:47 INFO - 'cart']}, 01:48:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:48:47 INFO - 'tests': ['tsvgx', 01:48:47 INFO - 'tsvgr_opacity', 01:48:47 INFO - 'tart', 01:48:47 INFO - 'tscrollx', 01:48:47 INFO - 'cart']}, 01:48:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:47 INFO - 'tests': ['tp5o']}, 01:48:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:47 INFO - 'talos_options': ['--e10s'], 01:48:47 INFO - 'tests': ['tp5o']}, 01:48:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:47 INFO - 'talos_options': ['--xperf_path', 01:48:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:48:47 INFO - 'tests': ['tp5n']}, 01:48:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:47 INFO - 'talos_options': ['--e10s', 01:48:47 INFO - '--xperf_path', 01:48:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:48:47 INFO - 'tests': ['tp5n']}}, 01:48:47 INFO - 'talos.zip': {'path': '', 01:48:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:48:47 INFO - Running post-action listener: _resource_record_post_action 01:48:47 INFO - ##### 01:48:47 INFO - ##### Running create-virtualenv step. 01:48:47 INFO - ##### 01:48:47 INFO - Running pre-action listener: _resource_record_pre_action 01:48:47 INFO - Running main action method: create_virtualenv 01:48:47 INFO - Creating virtualenv /builds/slave/test/build/venv 01:48:47 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 01:48:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:48:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:48:47 INFO - Using real prefix '/tools/python27' 01:48:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:48:47 INFO - Installing distribute.............................................................................................................................................................................................done. 01:48:50 INFO - Installing pip.................done. 01:48:50 INFO - Return code: 0 01:48:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:48:50 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')]} 01:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:50 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')]} 01:48:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:50 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 0x104f09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f104c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84e3d9d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dadd30>, '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 0x104c11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da4b20>, '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.MEHc2FmTVZ/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.6sXRocbcx7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 01:48:50 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 01:48:50 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 01:48:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MEHc2FmTVZ/Render', 01:48:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:50 INFO - 'HOME': '/Users/cltbld', 01:48:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:50 INFO - 'LOGNAME': 'cltbld', 01:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:50 INFO - 'MOZ_NO_REMOTE': '1', 01:48:50 INFO - 'NO_EM_RESTART': '1', 01:48:50 INFO - 'PAGER': '/bin/cat', 01:48:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:50 INFO - 'PWD': '/builds/slave/test', 01:48:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:50 INFO - 'SHELL': '/bin/bash', 01:48:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6sXRocbcx7/Listeners', 01:48:50 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 01:48:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:50 INFO - 'USER': 'cltbld', 01:48:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:50 INFO - 'XPC_FLAGS': '0x0', 01:48:50 INFO - 'XPC_SERVICE_NAME': '0', 01:48:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:51 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 01:48:51 INFO - Cleaning up... 01:48:51 INFO - Return code: 0 01:48:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:51 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 0x104f09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f104c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84e3d9d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dadd30>, '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 0x104c11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da4b20>, '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.MEHc2FmTVZ/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.6sXRocbcx7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 01:48:51 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 01:48:51 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 01:48:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MEHc2FmTVZ/Render', 01:48:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:51 INFO - 'HOME': '/Users/cltbld', 01:48:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:51 INFO - 'LOGNAME': 'cltbld', 01:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:51 INFO - 'MOZ_NO_REMOTE': '1', 01:48:51 INFO - 'NO_EM_RESTART': '1', 01:48:51 INFO - 'PAGER': '/bin/cat', 01:48:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:51 INFO - 'PWD': '/builds/slave/test', 01:48:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:51 INFO - 'SHELL': '/bin/bash', 01:48:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6sXRocbcx7/Listeners', 01:48:51 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 01:48:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:51 INFO - 'USER': 'cltbld', 01:48:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:51 INFO - 'XPC_FLAGS': '0x0', 01:48:51 INFO - 'XPC_SERVICE_NAME': '0', 01:48:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:51 INFO - Downloading/unpacking psutil>=0.7.1 01:48:51 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 01:48:51 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 01:48:51 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 01:48:51 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 01:48:51 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 01:48:51 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 01:48:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:48:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:48:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:48:54 INFO - Installing collected packages: psutil 01:48:54 INFO - Running setup.py install for psutil 01:48:54 INFO - building 'psutil._psutil_osx' extension 01:48:54 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 01:48:54 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 01:48:54 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 01:48:54 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 01:48:55 INFO - building 'psutil._psutil_posix' extension 01:48:55 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 01:48:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:48:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:48:55 INFO - ^ 01:48:55 INFO - 1 warning generated. 01:48:55 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 01:48:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:48:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:48:55 INFO - Successfully installed psutil 01:48:55 INFO - Cleaning up... 01:48:55 INFO - Return code: 0 01:48:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:48:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104f09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f104c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84e3d9d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dadd30>, '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 0x104c11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da4b20>, '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.MEHc2FmTVZ/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.6sXRocbcx7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 01:48:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:48:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MEHc2FmTVZ/Render', 01:48:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:55 INFO - 'HOME': '/Users/cltbld', 01:48:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:55 INFO - 'LOGNAME': 'cltbld', 01:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:55 INFO - 'MOZ_NO_REMOTE': '1', 01:48:55 INFO - 'NO_EM_RESTART': '1', 01:48:55 INFO - 'PAGER': '/bin/cat', 01:48:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:55 INFO - 'PWD': '/builds/slave/test', 01:48:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:55 INFO - 'SHELL': '/bin/bash', 01:48:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6sXRocbcx7/Listeners', 01:48:55 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 01:48:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:55 INFO - 'USER': 'cltbld', 01:48:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:55 INFO - 'XPC_FLAGS': '0x0', 01:48:55 INFO - 'XPC_SERVICE_NAME': '0', 01:48:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:48:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:48:58 INFO - Installing collected packages: mozsystemmonitor 01:48:58 INFO - Running setup.py install for mozsystemmonitor 01:48:58 INFO - Successfully installed mozsystemmonitor 01:48:58 INFO - Cleaning up... 01:48:58 INFO - Return code: 0 01:48:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:48:58 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')]} 01:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:58 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')]} 01:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:58 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 0x104f09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f104c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84e3d9d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dadd30>, '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 0x104c11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da4b20>, '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.MEHc2FmTVZ/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.6sXRocbcx7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 01:48:58 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 01:48:58 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 01:48:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MEHc2FmTVZ/Render', 01:48:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:58 INFO - 'HOME': '/Users/cltbld', 01:48:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:58 INFO - 'LOGNAME': 'cltbld', 01:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:58 INFO - 'MOZ_NO_REMOTE': '1', 01:48:58 INFO - 'NO_EM_RESTART': '1', 01:48:58 INFO - 'PAGER': '/bin/cat', 01:48:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:58 INFO - 'PWD': '/builds/slave/test', 01:48:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:58 INFO - 'SHELL': '/bin/bash', 01:48:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6sXRocbcx7/Listeners', 01:48:58 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 01:48:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:58 INFO - 'USER': 'cltbld', 01:48:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:58 INFO - 'XPC_FLAGS': '0x0', 01:48:58 INFO - 'XPC_SERVICE_NAME': '0', 01:48:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:58 INFO - Downloading/unpacking blobuploader==1.2.4 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:49:00 INFO - Downloading blobuploader-1.2.4.tar.gz 01:49:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:49:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:49:00 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 01:49:00 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 01:49:00 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 01:49:00 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 01:49:00 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 01:49:00 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 01:49:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:49:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:49:01 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 01:49:01 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 01:49:01 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 01:49:01 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 01:49:01 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 01:49:01 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 01:49:01 INFO - Downloading docopt-0.6.1.tar.gz 01:49:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:49:02 INFO - Installing collected packages: blobuploader, requests, docopt 01:49:02 INFO - Running setup.py install for blobuploader 01:49:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:49:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:49:02 INFO - Running setup.py install for requests 01:49:02 INFO - Running setup.py install for docopt 01:49:02 INFO - Successfully installed blobuploader requests docopt 01:49:02 INFO - Cleaning up... 01:49:02 INFO - Return code: 0 01:49:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:03 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 0x104f09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f104c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84e3d9d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dadd30>, '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 0x104c11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da4b20>, '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.MEHc2FmTVZ/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.6sXRocbcx7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 01:49:03 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 01:49:03 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 01:49:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MEHc2FmTVZ/Render', 01:49:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:49:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:49:03 INFO - 'HOME': '/Users/cltbld', 01:49:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:49:03 INFO - 'LOGNAME': 'cltbld', 01:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:03 INFO - 'MOZ_NO_REMOTE': '1', 01:49:03 INFO - 'NO_EM_RESTART': '1', 01:49:03 INFO - 'PAGER': '/bin/cat', 01:49:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:03 INFO - 'PWD': '/builds/slave/test', 01:49:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:49:03 INFO - 'SHELL': '/bin/bash', 01:49:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6sXRocbcx7/Listeners', 01:49:03 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 01:49:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:49:03 INFO - 'USER': 'cltbld', 01:49:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:49:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:03 INFO - 'XPC_FLAGS': '0x0', 01:49:03 INFO - 'XPC_SERVICE_NAME': '0', 01:49:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:49:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:49:03 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-8wfsCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:49:04 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-1wYUBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:49:04 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-hlAgIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:49:04 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-cmZWAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:49:04 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-qBg0qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:49:04 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-z_C5X_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:49:04 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-uny3Ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:49:04 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-gXT9YW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:49:04 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-uFrjek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:49:04 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-PkpLo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:49:04 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-kGBZEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:49:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:49:05 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-hWQ_ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:49:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:49:05 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-_lraUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:49:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:49:05 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-nBdZoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:49:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:49:05 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-p1cn7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:49:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:49:05 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-l9qWMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:49:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:49:05 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-kUfom8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:49:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:49:05 INFO - Running setup.py install for manifestparser 01:49:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:49:05 INFO - Running setup.py install for mozcrash 01:49:05 INFO - Running setup.py install for mozdebug 01:49:06 INFO - Running setup.py install for mozdevice 01:49:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:49:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:49:06 INFO - Running setup.py install for mozfile 01:49:06 INFO - Running setup.py install for mozhttpd 01:49:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:49:06 INFO - Running setup.py install for mozinfo 01:49:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:49:06 INFO - Running setup.py install for mozInstall 01:49:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:49:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:49:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:49:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:49:06 INFO - Running setup.py install for mozleak 01:49:06 INFO - Running setup.py install for mozlog 01:49:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:49:07 INFO - Running setup.py install for moznetwork 01:49:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:49:07 INFO - Running setup.py install for mozprocess 01:49:07 INFO - Running setup.py install for mozprofile 01:49:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:49:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:49:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:49:07 INFO - Running setup.py install for mozrunner 01:49:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:49:07 INFO - Running setup.py install for mozscreenshot 01:49:07 INFO - Running setup.py install for moztest 01:49:08 INFO - Running setup.py install for mozversion 01:49:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:49:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:49:08 INFO - Cleaning up... 01:49:08 INFO - Return code: 0 01:49:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:49:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:08 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 0x104f09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f104c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84e3d9d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dadd30>, '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 0x104c11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da4b20>, '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.MEHc2FmTVZ/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.6sXRocbcx7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 01:49:08 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 01:49:08 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 01:49:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MEHc2FmTVZ/Render', 01:49:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:49:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:49:08 INFO - 'HOME': '/Users/cltbld', 01:49:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:49:08 INFO - 'LOGNAME': 'cltbld', 01:49:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:08 INFO - 'MOZ_NO_REMOTE': '1', 01:49:08 INFO - 'NO_EM_RESTART': '1', 01:49:08 INFO - 'PAGER': '/bin/cat', 01:49:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:49:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:08 INFO - 'PWD': '/builds/slave/test', 01:49:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:49:08 INFO - 'SHELL': '/bin/bash', 01:49:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6sXRocbcx7/Listeners', 01:49:08 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 01:49:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:49:08 INFO - 'USER': 'cltbld', 01:49:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:49:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:49:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:08 INFO - 'XPC_FLAGS': '0x0', 01:49:08 INFO - 'XPC_SERVICE_NAME': '0', 01:49:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:49:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:49:08 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-4dL1H_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:49:08 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)) 01:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:49:08 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-ryHN_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:49:08 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)) 01:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:49:08 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-MlGlXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:49:08 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)) 01:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:49:08 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-PmpobY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:49:08 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)) 01:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:49:08 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-IofeF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:49:09 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)) 01:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:49:09 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-kRKo73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:49:09 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)) 01:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:49:09 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-ikepGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:49:09 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)) 01:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:49:09 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-eKpupm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:49:09 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)) 01:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:49:09 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-jZpioG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:49:09 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)) 01:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:49:09 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-yDduBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:49:09 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)) 01:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:49:09 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-8BJdZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:49:09 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)) 01:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:49:09 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-8SLVB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:49:09 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)) 01:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:49:09 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-XHJHWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:49:09 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)) 01:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:49:09 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-HqnB7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:49:09 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)) 01:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:49:09 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-giW6AQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:49:10 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)) 01:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:49:10 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-p7TXoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:49:10 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)) 01:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:49:10 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-q0QFYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:49:10 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)) 01:49:10 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)) 01:49:10 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)) 01:49:10 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)) 01:49:10 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)) 01:49:10 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)) 01:49:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:49:10 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 01:49:10 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 01:49:10 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 01:49:10 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 01:49:10 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 01:49:10 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 01:49:12 INFO - Downloading blessings-1.6.tar.gz 01:49:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:49:13 INFO - Installing collected packages: blessings 01:49:13 INFO - Running setup.py install for blessings 01:49:13 INFO - Successfully installed blessings 01:49:13 INFO - Cleaning up... 01:49:13 INFO - Return code: 0 01:49:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:49:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:49:13 INFO - Reading from file tmpfile_stdout 01:49:13 INFO - Current package versions: 01:49:13 INFO - blessings == 1.6 01:49:13 INFO - blobuploader == 1.2.4 01:49:13 INFO - docopt == 0.6.1 01:49:13 INFO - manifestparser == 1.1 01:49:13 INFO - mozInstall == 1.12 01:49:13 INFO - mozcrash == 0.17 01:49:13 INFO - mozdebug == 0.1 01:49:13 INFO - mozdevice == 0.48 01:49:13 INFO - mozfile == 1.2 01:49:13 INFO - mozhttpd == 0.7 01:49:13 INFO - mozinfo == 0.9 01:49:13 INFO - mozleak == 0.1 01:49:13 INFO - mozlog == 3.1 01:49:13 INFO - moznetwork == 0.27 01:49:13 INFO - mozprocess == 0.22 01:49:13 INFO - mozprofile == 0.28 01:49:13 INFO - mozrunner == 6.11 01:49:13 INFO - mozscreenshot == 0.1 01:49:13 INFO - mozsystemmonitor == 0.0 01:49:13 INFO - moztest == 0.7 01:49:13 INFO - mozversion == 1.4 01:49:13 INFO - psutil == 3.1.1 01:49:13 INFO - requests == 1.2.3 01:49:13 INFO - wsgiref == 0.1.2 01:49:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:49: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')]} 01:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49: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')]} 01:49:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:13 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 0x104f09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f104c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84e3d9d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dadd30>, '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 0x104c11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da4b20>, '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.MEHc2FmTVZ/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.6sXRocbcx7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 01:49:13 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 01:49:13 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 01:49:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MEHc2FmTVZ/Render', 01:49:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:49:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:49:13 INFO - 'HOME': '/Users/cltbld', 01:49:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:49:13 INFO - 'LOGNAME': 'cltbld', 01:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:13 INFO - 'MOZ_NO_REMOTE': '1', 01:49:13 INFO - 'NO_EM_RESTART': '1', 01:49:13 INFO - 'PAGER': '/bin/cat', 01:49:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:13 INFO - 'PWD': '/builds/slave/test', 01:49:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:49:13 INFO - 'SHELL': '/bin/bash', 01:49:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6sXRocbcx7/Listeners', 01:49:13 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 01:49:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:49:13 INFO - 'USER': 'cltbld', 01:49:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:49:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:13 INFO - 'XPC_FLAGS': '0x0', 01:49:13 INFO - 'XPC_SERVICE_NAME': '0', 01:49:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:13 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)) 01:49:13 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)) 01:49:13 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)) 01:49:13 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)) 01:49:13 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)) 01:49:13 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)) 01:49:13 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)) 01:49:13 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)) 01:49:13 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)) 01:49:13 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)) 01:49:13 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)) 01:49:13 INFO - Cleaning up... 01:49:13 INFO - Return code: 0 01:49:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:49: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')]} 01:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49: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')]} 01:49:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:13 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 0x104f09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f104c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84e3d9d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dadd30>, '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 0x104c11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da4b20>, '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.MEHc2FmTVZ/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.6sXRocbcx7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 01:49:13 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 01:49:13 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 01:49:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MEHc2FmTVZ/Render', 01:49:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:49:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:49:13 INFO - 'HOME': '/Users/cltbld', 01:49:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:49:13 INFO - 'LOGNAME': 'cltbld', 01:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:13 INFO - 'MOZ_NO_REMOTE': '1', 01:49:13 INFO - 'NO_EM_RESTART': '1', 01:49:13 INFO - 'PAGER': '/bin/cat', 01:49:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:13 INFO - 'PWD': '/builds/slave/test', 01:49:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:49:13 INFO - 'SHELL': '/bin/bash', 01:49:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6sXRocbcx7/Listeners', 01:49:13 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 01:49:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:49:13 INFO - 'USER': 'cltbld', 01:49:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:49:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:13 INFO - 'XPC_FLAGS': '0x0', 01:49:13 INFO - 'XPC_SERVICE_NAME': '0', 01:49:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:49:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:14 INFO - Downloading/unpacking jsonschema 01:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:49:16 INFO - Downloading/unpacking functools32 (from jsonschema) 01:49:16 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 01:49:16 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 01:49:16 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 01:49:16 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 01:49:16 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 01:49:16 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 01:49:16 INFO - Downloading functools32-3.2.3-2.tar.gz 01:49:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:49:16 INFO - warning: no files found matching '*.txt' 01:49:16 INFO - no previously-included directories found matching 'build' 01:49:16 INFO - no previously-included directories found matching 'dist' 01:49:16 INFO - no previously-included directories found matching '.git*' 01:49:16 INFO - Installing collected packages: jsonschema, functools32 01:49:16 INFO - Running setup.py install for functools32 01:49:17 INFO - warning: no files found matching '*.txt' 01:49:17 INFO - no previously-included directories found matching 'build' 01:49:17 INFO - no previously-included directories found matching 'dist' 01:49:17 INFO - no previously-included directories found matching '.git*' 01:49:17 INFO - Successfully installed jsonschema functools32 01:49:17 INFO - Cleaning up... 01:49:17 INFO - Return code: 0 01:49:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:49:17 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')]} 01:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:17 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')]} 01:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:17 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 0x104f09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f104c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84e3d9d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dadd30>, '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 0x104c11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da4b20>, '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.MEHc2FmTVZ/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.6sXRocbcx7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 01:49:17 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 01:49:17 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 01:49:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MEHc2FmTVZ/Render', 01:49:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:49:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:49:17 INFO - 'HOME': '/Users/cltbld', 01:49:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:49:17 INFO - 'LOGNAME': 'cltbld', 01:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:17 INFO - 'MOZ_NO_REMOTE': '1', 01:49:17 INFO - 'NO_EM_RESTART': '1', 01:49:17 INFO - 'PAGER': '/bin/cat', 01:49:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:17 INFO - 'PWD': '/builds/slave/test', 01:49:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:49:17 INFO - 'SHELL': '/bin/bash', 01:49:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6sXRocbcx7/Listeners', 01:49:17 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 01:49:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:49:17 INFO - 'USER': 'cltbld', 01:49:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:49:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:17 INFO - 'XPC_FLAGS': '0x0', 01:49:17 INFO - 'XPC_SERVICE_NAME': '0', 01:49:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:17 INFO - Downloading/unpacking flake8 01:49:17 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 01:49:17 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 01:49:17 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 01:49:17 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 01:49:17 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 01:49:17 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 01:49:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:49:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:49:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:49:20 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 01:49:20 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 01:49:20 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 01:49:20 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 01:49:20 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 01:49:20 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 01:49:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:49:20 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 01:49:20 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 01:49:20 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 01:49:20 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 01:49:20 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 01:49:20 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 01:49:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:49:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:49:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:49:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:49:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:49:20 INFO - no previously-included directories found matching 'docs/_build' 01:49:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:49:21 INFO - Running setup.py install for pep8 01:49:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:49:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:49:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:49:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:49:21 INFO - no previously-included directories found matching 'docs/_build' 01:49:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:49:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:49:21 INFO - Cleaning up... 01:49:21 INFO - Return code: 0 01:49:21 INFO - Running post-action listener: _resource_record_post_action 01:49:21 INFO - Running post-action listener: _start_resource_monitoring 01:49:21 INFO - Starting resource monitoring. 01:49:21 INFO - ##### 01:49:21 INFO - ##### Running install step. 01:49:21 INFO - ##### 01:49:21 INFO - Running pre-action listener: _resource_record_pre_action 01:49:21 INFO - Running main action method: install 01:49:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:49:21 INFO - Reading from file tmpfile_stdout 01:49:21 INFO - Detecting whether we're running mozinstall >=1.0... 01:49:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:49:21 INFO - Reading from file tmpfile_stdout 01:49:21 INFO - Output received: 01:49:21 INFO - Usage: mozinstall [options] installer 01:49:21 INFO - Options: 01:49:21 INFO - -h, --help show this help message and exit 01:49:21 INFO - -d DEST, --destination=DEST 01:49:21 INFO - Directory to install application into. [default: 01:49:21 INFO - "/builds/slave/test"] 01:49:21 INFO - --app=APP Application being installed. [default: firefox] 01:49:21 INFO - mkdir: /builds/slave/test/build/application 01:49:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 01:49:55 INFO - Reading from file tmpfile_stdout 01:49:55 INFO - Output received: 01:49:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:49:55 INFO - Running post-action listener: _resource_record_post_action 01:49:55 INFO - ##### 01:49:55 INFO - ##### Running run-tests step. 01:49:55 INFO - ##### 01:49:55 INFO - Running pre-action listener: _resource_record_pre_action 01:49:55 INFO - Running main action method: run_tests 01:49:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:49:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:49:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:49:55 INFO - 2016-03-08 01:49:55.562 screenresolution[1642:7468] starting screenresolution argv=screenresolution get 01:49:55 INFO - 2016-03-08 01:49:55.565 screenresolution[1642:7468] Display 0: 1600x1200x32@60 01:49:55 INFO - 2016-03-08 01:49:55.571 screenresolution[1643:7470] starting screenresolution argv=screenresolution list 01:49:55 INFO - Available Modes on Display 0 01:49:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:49:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:49:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:49:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:49:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:49:55 INFO - Intel Iris: 01:49:55 INFO - Chipset Model: Intel Iris 01:49:55 INFO - Type: GPU 01:49:55 INFO - Bus: Built-In 01:49:55 INFO - VRAM (Dynamic, Max): 1536 MB 01:49:55 INFO - Vendor: Intel (0x8086) 01:49:55 INFO - Device ID: 0x0a2e 01:49:55 INFO - Revision ID: 0x0009 01:49:55 INFO - Displays: 01:49:55 INFO - Display: 01:49:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:49:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:49:55 INFO - Display Serial Number: 1600x1200 60 01:49:55 INFO - Main Display: Yes 01:49:55 INFO - Mirror: Off 01:49:55 INFO - Online: Yes 01:49:55 INFO - Rotation: Supported 01:49:55 INFO - Return code: 0 01:49:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:49:55 INFO - Python 2.7.3 01:49:55 INFO - Return code: 0 01:49:55 INFO - grabbing minidump binary from tooltool 01:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:55 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 0x104dadd30>, '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 0x104c11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:49:55 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 01:49:55 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 01:49:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:49:55 INFO - Return code: 0 01:49:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:49:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:49:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:49:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:49:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:49:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:49:57 INFO - Return code: 0 01:49:57 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0187', '--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 01:49:57 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0187 --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 01:49:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MEHc2FmTVZ/Render', 01:49:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:49:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:49:57 INFO - 'HOME': '/Users/cltbld', 01:49:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:49:57 INFO - 'LOGNAME': 'cltbld', 01:49:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:49:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:57 INFO - 'MOZ_NO_REMOTE': '1', 01:49:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:49:57 INFO - 'NO_EM_RESTART': '1', 01:49:57 INFO - 'PAGER': '/bin/cat', 01:49:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:57 INFO - 'PWD': '/builds/slave/test', 01:49:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:49:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:49:57 INFO - 'SHELL': '/bin/bash', 01:49:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6sXRocbcx7/Listeners', 01:49:57 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 01:49:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:49:57 INFO - 'USER': 'cltbld', 01:49:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:49:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:57 INFO - 'XPC_FLAGS': '0x0', 01:49:57 INFO - 'XPC_SERVICE_NAME': '0', 01:49:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:49:57 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0187', '--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 01:49:57 INFO - mozversion application_buildid: 20160307110830 01:49:57 INFO - mozversion application_changeset: a06ac8e3220aa7bb49f5b755936078772a2b7464 01:49:57 INFO - mozversion application_display_name: Nightly 01:49:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:49:57 INFO - mozversion application_name: Firefox 01:49:57 INFO - mozversion application_remotingname: firefox 01:49:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:49:57 INFO - mozversion application_vendor: Mozilla 01:49:57 INFO - mozversion application_version: 47.0a1 01:49:57 INFO - mozversion platform_buildid: 20160307110830 01:49:57 INFO - mozversion platform_changeset: a06ac8e3220aa7bb49f5b755936078772a2b7464 01:49:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:49:57 INFO - mozversion platform_version: 47.0a1 01:49:57 INFO - using testdate: 1457430597 01:49:57 INFO - actual date: 1457430597 01:49:57 INFO - starting webserver on 'localhost:49275' 01:49:57 INFO - SUITE-START | Running 2 tests 01:49:57 INFO - TEST-START | dromaeo_css 01:49:57 INFO - operating with platform_type : mac_ 01:49:57 INFO - Initialising browser for dromaeo_css test... 01:49:57 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/tmpw_z0q8/profile http://localhost:49275/getInfo.html) 01:49:59 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 01:49:59 INFO - PROCESS | 1661 | colorDepth:24 01:49:59 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 01:49:59 INFO - PROCESS | 1661 | __metrics 01:49:59 INFO - PROCESS | 1661 | 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" 01:49:59 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:50:00 INFO - TEST-INFO | 1661: exit 0 01:50:00 INFO - Browser initialized. 01:50:00 INFO - Running cycle 1/1 for dromaeo_css test... 01:50:00 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/tmpw_z0q8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:50:12 INFO - PROCESS | 1664 | RSS: Main: 243851264 01:50:12 INFO - PROCESS | 1664 | 01:51:03 INFO - PROCESS | 1664 | 1457430663334 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] 01:53:13 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 01:53:14 INFO - PROCESS | 1664 | RSS: Main: 384352256 01:53:14 INFO - PROCESS | 1664 | 01:56:17 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 01:56:18 INFO - PROCESS | 1664 | RSS: Main: 380129280 01:56:18 INFO - PROCESS | 1664 | 01:59:20 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 01:59:20 INFO - PROCESS | 1664 | RSS: Main: 373727232 01:59:20 INFO - PROCESS | 1664 | 02:02:22 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 02:02:23 INFO - PROCESS | 1664 | RSS: Main: 334143488 02:02:23 INFO - PROCESS | 1664 | 02:05:26 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 02:05:27 INFO - PROCESS | 1664 | RSS: Main: 331186176 02:05:27 INFO - PROCESS | 1664 | 02:08:29 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 02:08:30 INFO - PROCESS | 1664 | RSS: Main: 389206016 02:08:30 INFO - PROCESS | 1664 | 02:08:30 INFO - PROCESS | 1664 | __start_tp_report 02:08:30 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 02:08:30 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 02:08:30 INFO - PROCESS | 1664 | |i|pagename|runs| 02:08:30 INFO - PROCESS | 1664 | |0;dojo.html;3401.455767077268;3456.377851986643;3492.947605785912;3501.2647344057746;3524.68277854993;5505.064139096353;5594.216809646648;5611.523020543248;5632;5661.745221465034;5584.748686309115;5653.236813030239;5669.348024977129;5731.627444216134;5750.763585829046;5066.974665126688;5092.210707340369;5137.845864624049;5141.691498510101;5237.47625237477;5217.217417387385;5217.2695822584865;5262.973685131588;5280.419153893069;5302.549283310923;5030.82392116276;5089.05852417304;5125.077486052528;5170.379554453452;5203.869903252449;5144.125498665198;5151.665141765773;5156.74216289184;5175.637705360627;5175.9906818170475;5094.5160209780015;5109.872253193663;5123.077845987721;5143.228515722634;5188.662736922126;5446.319210098738;5523;5551.805686800983;5557.6109672322955;5658.886822263573;6197.442230199304;6199.752009919643;6215.595986260879;6231.844203894893;6244.687765611701;6188.350223226541;6236.812895613139;6251.374862513758;6253.062040693887;6277.560570760049;5637.520810731093;5684.4315568443235;5750;5797.768089276466;5801.477866991991;6218.160548326008;6220.409061139185;6224.937750622526;6242.063690446469;6247.094171345129;5998.550108741862;6019.849503762441;6070.271567411939;6094.2077529920825;6100.176476175749;6092.908606370908;6149.3235744068115;6166.969165154235;6229.345918678564;6241.126242326078;6186.845328866724;6191.071339299051;6191.102290167901;6198.969005154945;6200.0699895015205;6216.937830621636;6217.9689101555105;6218.968905155445;6220.34686357935;6235.563510554309;4776.880577985578;4820.421549414093;4854.80580776765;4859.635527335464;4866.318715379779;4371.715838470489;4394.143142087262;4416.514183439819;4430.490493593278;4430.977845110754;5634.295713035871;5638.774449021993;5642.435756424325;5647.689377084218;5661.179129026268;6159.137720719103;6163.075538669146;6176.969115154396;6246.3753624637175;6248.687565621701;5661.915071273934;5664.320281566238;5669.036263835158;5682.602217844794;5696.943030569641;5312.893742125213;5330.840074797762;5336.626436149432;5341.359036915517;5369.221462887859;6195.19462469876;6219.160413344141;6260.686965651699;6306.684665766602;6328.810135695937;6218.782342617987;6240.53196010292;6251.374862513712;6258;6259.718312676032;6192.102145189013;6234.314225435108;6240.12638230639;6260.499160067275;6267.9373206267355;6097.827165393427;6120;6156.322804491413;6165.568410211422;6194.907076393948;6233.096201050913;6239.469645080219;6246.969250073687;6254.562180647493;6260.373962603703;4303.483581970058;5892.499137573182;6009.54928380382;6070.757169713162;6105.9694701526205;6036.849078773066;6069.605475644069;6076.361981991828;6097.969510152599;6123.938760612336;5848.181254624441;5892.292924849045;5898.380670029585;5914.201582786441;5928.170056192223;5880.470757631662;6017.849553761191;6071.787487437919;6075.149479072845;6082.178905847654;5882.617629854046;5904;5913.645181289136;5919.437653422918;5929.495992840657 02:08:30 INFO - PROCESS | 1664 | |1;ext.html;493.50402845140604;507.53828972559023;549.8460431079296;626.9968650156749;637.5696404926675;37718.62281377186;38647.80676096619;38795.418068728955;38872;38894.72158062611;43147;43625.47310844113;43631.99999999992;43723;44028.55971440284;9583.664571740008;9814.656487022956;9819.950900245489;9827.066428689262;9830.754231144243;8582.399232053758;9328.020557841397;9714.028597140301;9882.752931176707;9893.752656183617;9822.803543929118;9897.356671816346;9899.15857152143;9906.05892440217;9929.90070099297;9798.167155791767;9873.160781333523;9875.555599998017;9877.753056173582;9878.851817222747;9606.471644059575;9744.75638109046;9748.561314740853;9748.561314740853;9749.36629119105;40329.596704032876;40627.78116656475;40632.59367406317;40645.390319145234;40696.59303406958;3269.75476839238;3305.93388132236;3446.4141096013736;3465.094198190985;3893.3186692329014;27950.16149515518;29480.410391792044;29496.557551636743;29545.40909181826;29603.555946660817;2700.1494529223232;2838.0066976558246;2873.396586716792;2884.2645125493073;2973.018903761775;481524;484401;484423;484802;485024.14975850494;66987.29646090664;67374;67380;67389;67499.66250168816;70924;71054.93417598741;71066.64466677634;71187.28812711807;71353.28646713571;15471.22643867802;17211.31154753796;17465.21406536709;17488.30046798114;17496.65006699884;11717.765644687059;11771.587994420326;11781;11792.29246245228;13295.401706923212;16608.508268976642;22537.549249014926;22730.659040114413;22842.54314913726;22904.312870613907;8337.624806883705;9823.508824558743;9951.601935922627;10073.517284808337;10093.69718908434;955.8231727130503;976.72651657536;1004.8593196952286;1061.0238580505952;1096.9890301097046;27573;28174.71825281762;28295.575566366522;29062.85481959677;29307.413851722846;911.9635214591342;1060.4379678770265;1090.0571006079842;1131.4682099413262;1146.9655910322704;14514.056586321854;14885.553433396799;15008.774868376982;15009.324580393908;15640.296186671627;537015;627893;631952;634726;637348;57462.85074298574;59849.700751496835;60449.488762781286;60624.09063864045;60705;1360.5986234060977;1492.149474799354;1512.0096336899348;1513.8561836625504;1631.796025496813;25769.71151442458;26672.733272667025;28326.43347133087;28527.42945141127;28688.856555717088;44950.325745114504;45477.772611138054;45703.314450283935;45754;45772.54227457816;331687;333826;334512;334971;489092;32872.671273286964;33833.66166338305;33858.32283354369;33877.83061084679;33895.66104339024;40325.39511907382;41294.38058429186;41333.79333103315;41441.96395090147;41897;34918.65081349255;34959.30081398409;34981.47527787034;35501;35659.82170089237;33827.81602643896;34056;34353.14117147091;34376;34677;34351.65648343485;34571.65428345785;34861;35172;35219.47170792492;30191;30515.08454746361;30602.693973059984;30610.92861749828;30817.537736933515;22242;23322.183723569593;23491.295261142193;23725.406864828517;23772 02:08:30 INFO - PROCESS | 1664 | |2;jquery.html;361.30448885894646;363.23357715220885;364.37691547453846;369.37944253653865;374.00887647733487;17114.486565403044;19859.503512412197;21075.367738967816;21103.6834447483;21132.788672113293;12420.254784712924;17085.974841509516;20908.26821061263;21771.891140544314;21773.891130544365;5202.921956170651;5431.619786614919;5484.341878974528;5489.451054894518;5490.780368785264;4287.356896465524;4458.1306645204195;5330.733463326837;7171.282871712813;7682.654280557388;7369.410447164214;7642.082950045974;7651.426143039266;7660.693572257103;7684.807879802994;7602.315791578757;7656.770296891103;7678.616069196546;7685.730999415049;7686.846263074764;4479.596836284717;4505.7296562206375;7207.423406127497;7224.349808517206;7310.597917114556;27040.323991900164;27857.58213626797;29062.564061539095;29360;29443.41113177746;2242.2264318809985;2351.2240960483;2792.2042217967783;2938.61797966263;3271.084096452997;14805.555833325017;15525.378984840592;15572.221388930508;15804.051756894623;16465.753013704805;1819.9909000455045;1907.3419670213755;1907.8473722102199;1938.030984507746;1946.5912158446743;119632;123916.38041809824;125199;125472.37263813714;129413.35293323472;18895.14971826271;19468.610627787366;19746.605067898563;19772.20911163566;19788.60422791565;29536.261593459905;29539.261518462212;29572.852135739184;29611.703882961327;29615.85192074069;8857.247133993682;10638.893611063944;10996.890031099747;11049.060829829554;11125.777484450266;9383.202427793714;9401.623935042659;9424.858627120599;9480.573374198178;9540.570674319672;8239.382046346547;8658.874346334936;8705.738827835175;8874.733757987271;8890.777730556787;2874.3532705141174;3521.2781379817075;3562.717421728176;3597.37046016946;3641.9635803642154;870.525563567857;927.3276874266103;959.1367769007949;994.8209322322051;1070.341739829999;17517.562060948578;19593.902030489757;19910.303139390053;20548.184793743658;20653.896730516553;946.0775743649887;946.8816397950256;963.4123184857232;992.2508506078009;1003.4581326083979;10931.56273749041;11197.104231661448;11197.328160310408;11200.495977681025;11220.495077721522;604253.5108462583;604707;610758;613458;624068;112931;120727.39636301938;131208;132347;134261;1033.9069483746348;1059.3379138038727;1076.8169411200115;1077.7682798198425;1080.2168427889717;18202;18431.170597322885;18578.81421185771;18894.716579251046;19068.427947161606;33431.832840836614;33728.458511855904;40360.79819600883;47525.20760675123;54805;74961.6251918737;75574;75989;76949.2305076942;78485;7947.245011723877;8035.799105022187;8079.717209897625;8174;8391.370647201362;8640.56797160127;9487.33588648788;12049;13255.337233138498;13675.111117777313;8133.2680058794995;8165.183481652025;8196.098429172906;8342.580651611208;11481.540738370371;7597.506162099446;7777.144514103331;8190.385721071063;8263.297619702393;8283.83432331338;7473.43949203801;8339;8375.37184711137;8633.481991080555;8643.222110010129;11626.418679065844;11820;11937.16439849237;12000.912843308502;12139;10616.044555989998;11283.097352211638;11895.717541685159;12108.152429329863;12121.939390302992 02:08:30 INFO - PROCESS | 1664 | |3;mootools.html;1420.3111490926892;1545.0883978452712;1563.1480842940596;1843.4838245291323;2012.4365177750235;7986.121526632066;8491.193336633018;8611.526366049864;8624.655013799456;8636.784080397993;7358.859376796591;8426.494410335385;8654.783630409227;8691.043985161627;8718;2182.519845633958;2246.629306164481;2251.8536295140843;2468.568000599901;2505.24842547236;2048.2319130326127;2488.4322876587726;2512.510060538196;2513.1078467144175;2517.672702548666;2423.587990041697;2433.1605596069326;2437.9878100609562;2472.307753828931;2481.280428675691;2475.492524032587;2488.4276616378243;2494.837835540693;2496.425822060927;2527.1155095716535;2425.4057755849753;2445.572024895654;2447.657327974085;2453.4234454903085;2457.299669594157;8863.556822158931;8886.155815197546;8901.198892099677;8905.154010369004;8917.55412229386;5367.838964831061;5503.642263252876;5539.14143307788;5548.667079975215;5569.610127291091;2963;3143.921401964946;3600.747947643666;3724.1992971511254;3724.7951362675312;1059.1420949031233;1069.0485467933545;1072.072657151566;1080.9082826345368;1088.2110469909333;12013.459394327276;12044.39778011096;12058.577949771803;12080.939595302056;12150.696232594168;4865.513448655177;4917.9918116785975;4942.061008408391;4957.3059771632;4990.10178167926;10228.64199753005;10254.692359229235;10256.435896025641;10266.845997310047;10335.741606459898;5537.086380747212;5545.251391062155;5549.667019978814;5552.278203833475;5568.276124103922;3582.2119133790525;4583.679142459996;4765.809367625326;5028.647994640413;5040.672356296829;3931.6264954829244;3965.0682089708894;3973.562908080109;4014.8394064237687;4020.4170395292517;1305.6866352075433;1313.7306852095298;1314.3756715560032;1324.4172564071778;1325.6221976736583;1335.052112999781;1338.4779935825036;1351.236551348485;1396.2250950722243;1397.2943663450096;7219.711211551584;7993.400494962901;8086.919130808734;8133.959330203429;8137.349012079019;522.5218924683948;523.1316015414394;526.4104203292337;529.9125644268653;533.5704757670113;6141.723622436912;6161.537884658668;6175.228096487939;6194.38056194386;6207.81376558704;10534.051935325857;10886.074683651977;10890.727731806768;10899.83650245247;10900.454977251105;10365.170786337076;10640.201984851166;10655.360678359324;10701.143908487302;10748.032677058945;8216.178382161735;8334.874976875473;8371.162883711702;8374.581270936429;8379.952505936757;7753.069631644239;7916.564588947663;7918.564478953483;8039.959800201195;8048.919510804817;9379.484128372733;9517.23862091045;9545.856812147962;9739.561719722487;9768.413895166028;9703;9937.900620993987;9987.250956178461;10094.343867648578;10099.545520451451;6759.222689390586;6783.4573234142135;7149.356557909813;7535.962320188364;7598.962005189938;8122.187781221831;8153.6738530458115;8190.50856948585;8196.672133114847;8212.425130240827;7191.784246472404;7296.96351518239;7300;7382.704691812267;7478.850422991619;7220.819479513054;7231.168415632059;7312.4881258313535;7347.375473084634;7370.078740157481;7735.33690256575;7818.179091195342;7819.609019549113;7830.569318687527;7836.529808211526;6887.690053947485;6975.407090397373;7081.150261968597;7084.22073571917;7084.36240738336;7127.964360178374;7196.4962452627815;7199.8560028800175;7216.675249613885;7219.819504512429 02:08:30 INFO - PROCESS | 1664 | |4;prototype.html;322.6644289938464;326.97711160218796;330.5058936889348;331.30260801013856;337.0209541282575;6532.216134063913;6573.276939536653;6602.1417215761885;6629.436497897673;6656.833579160523;6546.149000629912;6560.147180866481;6567.8358041049;6568.244651865037;6591.879380505314;4617.746023968681;4714.622830173578;4729.787159577827;4867.342908707333;4898.216285394329;4827.131116399047;4829.299751536025;4842.2252439609665;4864.829730959417;4884.120858245515;3900.7854567998747;4350.15172041452;4354.47746270448;4795.808167673306;4824.758762061901;4601.953980460203;4690.226112691419;4784.904301913943;4804.543568361;4819.325294458778;4101.8974525636795;4105.281575724236;4110;4112.3420252759415;4125;6250.937490625081;6291.339409361997;6301.180846489973;6308.148399965991;6316.715747791361;5719.857003574903;5742.483176514133;5752.482276595127;5753.482186603226;5756.1653560233535;6674.098996635489;6860.965695171542;6929.965350173217;6945.652717364112;6950.826229344257;4664.673472856902;4680.485146633868;4691.390119284471;4691.741954192518;4704.294355846616;7271.3092256236105;7315.963420182865;7334.643091028177;7349.669264883093;7351.77944661661;4754.857354279377;4758.262469317261;4759.1671457495495;4762.976185119052;4778.617710583145;4823;4824.155772739827;4830.347903033045;4836.806527738921;4845.466998630148;5725.627834190765;5728.971355143198;5742.397048309867;5744.712764361765;5750.1949727038245;6625.635590042498;6999.965000174967;7004.318963448735;7005.0893383859775;7034.50758446914;1654.544001278867;1661.5015495351588;1678.9580260493342;1679.1520282257627;1681.6048228666255;1019.0980981830985;1056.6196169379018;1086.766345235778;1095.2114477576133;1120.675004248775;5869.735861886225;6355.650439225795;6418.19772528434;6418.8716225675225;6494.675266236669;7316.926830731731;7327.8534429312185;7328.743493977685;7341.5405839044515;7345.706171753177;6594.769183078569;6606.834829129214;6616.768413105615;6623.4701223901975;6627;3819.923601527954;3852.499175107218;3860.478835357247;3861;3861.189150278473;7296.525725827804;7645.770626881203;7646.617669116522;7668.539887606761;7676.270754278335;7434.479586428898;7472.103347598214;7507.249275072449;7508.774736757906;7526.736564220336;7608.771736847903;7627.466077374531;7630.122535908331;7630.694772209049;7636.449051191223;7023.508065320137;7214.494985350975;7271.890921636285;7277.345038946309;7301.561906285639;7111.6799744010605;7170.282971702788;7172.211056783645;7172.928270717226;7201.819954501179;7591;7598.278163574451;7609.353204977639;7612.467127301035;7613.581253031137;4572.542745725401;4624.260118381043;4629.328747331685;4632.328312394751;4634.629229661687;6970.79087627372;7238.855222895408;7251.383632391306;7260.96369518149;7262.055932728711;6646.501512386687;7028.402585780062;7045.330693584101;7063.1524217094275;7086.078809754699;6201.255849298113;7000.579965202104;7026.086608740831;7027.648617569203;7043.401310888632;5913.615614985184;6586.604803711793;6855.211650660238;6898.344657257552;6902.516823822284;6705.932940670531;7046.260142684944;7054.541454805421;7058.11773528309;7079.1505019398;5757.424257574209;6482.837929051623;6762.4928130389435;6769.593824370553;6865.794026179223 02:08:30 INFO - PROCESS | 1664 | |5;yui.html;685.0375222811949;692.1244625548678;731.1043971135358;771.7453240430658;784.823414731685;15191.772123418157;15278.006929549572;15470.38118475261;15488.612784680388;15499.767503487443;14329.426822927071;14419;14456.783148252785;14460.493882714107;14506.984511084229;774.0363247756551;774.4501404003164;786.0724345272577;920.8158368326344;942.8491441369382;949.5299826585815;953.594722243044;956.1251454918742;957.4733896356976;959.5825815770128;1011.009210973243;1017.8982101789836;1019.0217391304357;1020.6835880876952;1024.549198352726;800.0039950261903;983.1593987141034;1008.5108722269694;1009.5002973528151;1009.5305682857506;742.9925700742978;744.2185705009719;744.437949348244;745.117036311972;745.3403737692181;15238.314275857612;15321.310541025681;15321.850861185456;15325.003874748105;15326.770098448533;12589.74820503594;12622.305773182472;12663.430145643468;12682.61952141428;12968.092233543655;10094.29339946204;10129.290949633529;10274.640387586398;10362.27464077515;11073.169512286611;3518.032541051206;3529.5764508258917;3532.7527073104893;3551.058969373118;3608.9639103608893;66684.99972500416;75509;79846.60076699637;80070.59964700197;80300.79548806831;9481.762955926019;9627.759306017406;9677.854832177523;9927.652532161339;9987.650432234837;22316.665250021262;22504.32487025392;22586.661200082013;22633.4341641457;22663;7443.181250062489;7475.028246328051;7620.3522700569965;7742.845143097219;7865.41009424284;4043.6562892153906;4124.1957818225155;4143.440635514167;4230.682698797541;4230.957690423056;3070.570120183176;3620.456931460302;3673.2653469306247;3690.317291301118;3691.003429074135;633.5241518670578;644.8742495213482;653.7254353171584;653.8823011857911;656.7143292667705;505.71427143663715;551.4154995704566;568.2470726287686;599.8040244276613;620.6586377492451;7572.318491335806;7674.42441816866;7776.261255180749;8035.879461808077;8153.103158652543;570.3912387905712;579.2932622200908;589.1310317281975;603.728322254987;605.2102006881063;3716.6097559756377;3761.153740408386;3803.581606023335;3844.8654297100024;4025.6578190854107;95121;95877.52061239649;96921.51539242259;99064.51403228957;99295.51056734155;77046;78166.6091669538;82359.76460353099;82508.58745706233;84359;70653;70968;72013.63993180105;72108.27891721121;72915.99999999894;7648.694052237848;7749.263819937097;7767.417443691858;7781.182975787461;7785.805354866174;49858.50141498539;50812.729681758254;51157.48842511527;51170.48829511657;51261.46215613538;55756.72121639366;59422.92019779287;67520;67851;70383.64808175927;10151.289409741246;10305.330153539995;10354.948225258826;10451.059404653617;10933.83599245996;10806;10809.243352965217;10959.12327013821;11228.10175185967;11381.715457113638;8322.45904016237;9972;10135.290529662852;10407.06336429725;10462.63380781669;10375.584976600852;10667.413292269;10707.518161682587;10761.892381076403;10817.296875703054;9962.252831037556;10110.090091891765;10246.948765256424;10533.315334503233;10784;8529.317654587494;8573.356998225034;8624.741257762276;8840;8855.512946787989;8546.529940853312;8727.432716873383;8809.559522023745;8981.506017169118;9351.625934962525 02:08:30 INFO - PROCESS | 1664 | __end_tp_report 02:08:30 INFO - PROCESS | 1664 | __start_cc_report 02:08:30 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1283 02:08:30 INFO - PROCESS | 1664 | __end_cc_report 02:08:30 INFO - PROCESS | 1664 | __startTimestamp1457431710227__endTimestamp 02:08:30 INFO - PROCESS | 1664 | 02:08:30 INFO - PROCESS | 1664 | ------- Summary: start ------- 02:08:30 INFO - PROCESS | 1664 | Number of tests: 6 02:08:30 INFO - PROCESS | 1664 | 02:08:30 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5697.35 Median:5904.00 stddev:634.81 (10.8%) stddev-sans-first:610.67 02:08:30 INFO - PROCESS | 1664 | Values: 3401.5 3456.4 3492.9 3501.3 3524.7 5505.1 5594.2 5611.5 5632.0 5661.7 5584.7 5653.2 5669.3 5731.6 5750.8 5067.0 5092.2 5137.8 5141.7 5237.5 5217.2 5217.3 5263.0 5280.4 5302.5 5030.8 5089.1 5125.1 5170.4 5203.9 5144.1 5151.7 5156.7 5175.6 5176.0 5094.5 5109.9 5123.1 5143.2 5188.7 5446.3 5523.0 5551.8 5557.6 5658.9 6197.4 6199.8 6215.6 6231.8 6244.7 6188.4 6236.8 6251.4 6253.1 6277.6 5637.5 5684.4 5750.0 5797.8 5801.5 6218.2 6220.4 6224.9 6242.1 6247.1 5998.6 6019.8 6070.3 6094.2 6100.2 6092.9 6149.3 6167.0 6229.3 6241.1 6186.8 6191.1 6191.1 6199.0 6200.1 6216.9 6218.0 6219.0 6220.3 6235.6 4776.9 4820.4 4854.8 4859.6 4866.3 4371.7 4394.1 4416.5 4430.5 4431.0 5634.3 5638.8 5642.4 5647.7 5661.2 6159.1 6163.1 6177.0 6246.4 6248.7 5661.9 5664.3 5669.0 5682.6 5696.9 5312.9 5330.8 5336.6 5341.4 5369.2 6195.2 6219.2 6260.7 6306.7 6328.8 6218.8 6240.5 6251.4 6258.0 6259.7 6192.1 6234.3 6240.1 6260.5 6267.9 6097.8 6120.0 6156.3 6165.6 6194.9 6233.1 6239.5 6247.0 6254.6 6260.4 4303.5 5892.5 6009.5 6070.8 6106.0 6036.8 6069.6 6076.4 6098.0 6123.9 5848.2 5892.3 5898.4 5914.2 5928.2 5880.5 6017.8 6071.8 6075.1 6082.2 5882.6 5904.0 5913.6 5919.4 5929.5 02:08:30 INFO - PROCESS | 1664 | 02:08:30 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:63391.98 Median:35580.41 stddev:133409.60 (375.0%) stddev-sans-first:133700.27 02:08:30 INFO - PROCESS | 1664 | Values: 493.5 507.5 549.8 627.0 637.6 37718.6 38647.8 38795.4 38872.0 38894.7 43147.0 43625.5 43632.0 43723.0 44028.6 9583.7 9814.7 9820.0 9827.1 9830.8 8582.4 9328.0 9714.0 9882.8 9893.8 9822.8 9897.4 9899.2 9906.1 9929.9 9798.2 9873.2 9875.6 9877.8 9878.9 9606.5 9744.8 9748.6 9748.6 9749.4 40329.6 40627.8 40632.6 40645.4 40696.6 3269.8 3305.9 3446.4 3465.1 3893.3 27950.2 29480.4 29496.6 29545.4 29603.6 2700.1 2838.0 2873.4 2884.3 2973.0 481524.0 484401.0 484423.0 484802.0 485024.1 66987.3 67374.0 67380.0 67389.0 67499.7 70924.0 71054.9 71066.6 71187.3 71353.3 15471.2 17211.3 17465.2 17488.3 17496.7 11717.8 11771.6 11781.0 11792.3 13295.4 16608.5 22537.5 22730.7 22842.5 22904.3 8337.6 9823.5 9951.6 10073.5 10093.7 955.8 976.7 1004.9 1061.0 1097.0 27573.0 28174.7 28295.6 29062.9 29307.4 912.0 1060.4 1090.1 1131.5 1147.0 14514.1 14885.6 15008.8 15009.3 15640.3 537015.0 627893.0 631952.0 634726.0 637348.0 57462.9 59849.7 60449.5 60624.1 60705.0 1360.6 1492.1 1512.0 1513.9 1631.8 25769.7 26672.7 28326.4 28527.4 28688.9 44950.3 45477.8 45703.3 45754.0 45772.5 331687.0 333826.0 334512.0 334971.0 489092.0 32872.7 33833.7 33858.3 33877.8 33895.7 40325.4 41294.4 41333.8 41442.0 41897.0 34918.7 34959.3 34981.5 35501.0 35659.8 33827.8 34056.0 34353.1 34376.0 34677.0 34351.7 34571.7 34861.0 35172.0 35219.5 30191.0 30515.1 30602.7 30610.9 30817.5 22242.0 23322.2 23491.3 23725.4 23772.0 02:08:30 INFO - PROCESS | 1664 | 02:08:30 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:36203.94 Median:18351.46 stddev:101819.70 (554.8%) stddev-sans-first:102069.77 02:08:30 INFO - PROCESS | 1664 | Values: 361.3 363.2 364.4 369.4 374.0 17114.5 19859.5 21075.4 21103.7 21132.8 12420.3 17086.0 20908.3 21771.9 21773.9 5202.9 5431.6 5484.3 5489.5 5490.8 4287.4 4458.1 5330.7 7171.3 7682.7 7369.4 7642.1 7651.4 7660.7 7684.8 7602.3 7656.8 7678.6 7685.7 7686.8 4479.6 4505.7 7207.4 7224.3 7310.6 27040.3 27857.6 29062.6 29360.0 29443.4 2242.2 2351.2 2792.2 2938.6 3271.1 14805.6 15525.4 15572.2 15804.1 16465.8 1820.0 1907.3 1907.8 1938.0 1946.6 119632.0 123916.4 125199.0 125472.4 129413.4 18895.1 19468.6 19746.6 19772.2 19788.6 29536.3 29539.3 29572.9 29611.7 29615.9 8857.2 10638.9 10996.9 11049.1 11125.8 9383.2 9401.6 9424.9 9480.6 9540.6 8239.4 8658.9 8705.7 8874.7 8890.8 2874.4 3521.3 3562.7 3597.4 3642.0 870.5 927.3 959.1 994.8 1070.3 17517.6 19593.9 19910.3 20548.2 20653.9 946.1 946.9 963.4 992.3 1003.5 10931.6 11197.1 11197.3 11200.5 11220.5 604253.5 604707.0 610758.0 613458.0 624068.0 112931.0 120727.4 131208.0 132347.0 134261.0 1033.9 1059.3 1076.8 1077.8 1080.2 18202.0 18431.2 18578.8 18894.7 19068.4 33431.8 33728.5 40360.8 47525.2 54805.0 74961.6 75574.0 75989.0 76949.2 78485.0 7947.2 8035.8 8079.7 8174.0 8391.4 8640.6 9487.3 12049.0 13255.3 13675.1 8133.3 8165.2 8196.1 8342.6 11481.5 7597.5 7777.1 8190.4 8263.3 8283.8 7473.4 8339.0 8375.4 8633.5 8643.2 11626.4 11820.0 11937.2 12000.9 12139.0 10616.0 11283.1 11895.7 12108.2 12121.9 02:08:30 INFO - PROCESS | 1664 | 02:08:30 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:6042.31 Median:531.74 stddev:3223.74 (606.3%) stddev-sans-first:3214.07 02:08:30 INFO - PROCESS | 1664 | Values: 1420.3 1545.1 1563.1 1843.5 2012.4 7986.1 8491.2 8611.5 8624.7 8636.8 7358.9 8426.5 8654.8 8691.0 8718.0 2182.5 2246.6 2251.9 2468.6 2505.2 2048.2 2488.4 2512.5 2513.1 2517.7 2423.6 2433.2 2438.0 2472.3 2481.3 2475.5 2488.4 2494.8 2496.4 2527.1 2425.4 2445.6 2447.7 2453.4 2457.3 8863.6 8886.2 8901.2 8905.2 8917.6 5367.8 5503.6 5539.1 5548.7 5569.6 2963.0 3143.9 3600.7 3724.2 3724.8 1059.1 1069.0 1072.1 1080.9 1088.2 12013.5 12044.4 12058.6 12080.9 12150.7 4865.5 4918.0 4942.1 4957.3 4990.1 10228.6 10254.7 10256.4 10266.8 10335.7 5537.1 5545.3 5549.7 5552.3 5568.3 3582.2 4583.7 4765.8 5028.6 5040.7 3931.6 3965.1 3973.6 4014.8 4020.4 1305.7 1313.7 1314.4 1324.4 1325.6 1335.1 1338.5 1351.2 1396.2 1397.3 7219.7 7993.4 8086.9 8134.0 8137.3 522.5 523.1 526.4 529.9 533.6 6141.7 6161.5 6175.2 6194.4 6207.8 10534.1 10886.1 10890.7 10899.8 10900.5 10365.2 10640.2 10655.4 10701.1 10748.0 8216.2 8334.9 8371.2 8374.6 8380.0 7753.1 7916.6 7918.6 8040.0 8048.9 9379.5 9517.2 9545.9 9739.6 9768.4 9703.0 9937.9 9987.3 10094.3 10099.5 6759.2 6783.5 7149.4 7536.0 7599.0 8122.2 8153.7 8190.5 8196.7 8212.4 7191.8 7297.0 7300.0 7382.7 7478.9 7220.8 7231.2 7312.5 7347.4 7370.1 7735.3 7818.2 7819.6 7830.6 7836.5 6887.7 6975.4 7081.2 7084.2 7084.4 7128.0 7196.5 7199.9 7216.7 7219.8 02:08:30 INFO - PROCESS | 1664 | 02:08:30 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:5748.32 Median:6553.15 stddev:1825.29 (27.9%) stddev-sans-first:1784.41 02:08:30 INFO - PROCESS | 1664 | Values: 322.7 327.0 330.5 331.3 337.0 6532.2 6573.3 6602.1 6629.4 6656.8 6546.1 6560.1 6567.8 6568.2 6591.9 4617.7 4714.6 4729.8 4867.3 4898.2 4827.1 4829.3 4842.2 4864.8 4884.1 3900.8 4350.2 4354.5 4795.8 4824.8 4602.0 4690.2 4784.9 4804.5 4819.3 4101.9 4105.3 4110.0 4112.3 4125.0 6250.9 6291.3 6301.2 6308.1 6316.7 5719.9 5742.5 5752.5 5753.5 5756.2 6674.1 6861.0 6930.0 6945.7 6950.8 4664.7 4680.5 4691.4 4691.7 4704.3 7271.3 7316.0 7334.6 7349.7 7351.8 4754.9 4758.3 4759.2 4763.0 4778.6 4823.0 4824.2 4830.3 4836.8 4845.5 5725.6 5729.0 5742.4 5744.7 5750.2 6625.6 7000.0 7004.3 7005.1 7034.5 1654.5 1661.5 1679.0 1679.2 1681.6 1019.1 1056.6 1086.8 1095.2 1120.7 5869.7 6355.7 6418.2 6418.9 6494.7 7316.9 7327.9 7328.7 7341.5 7345.7 6594.8 6606.8 6616.8 6623.5 6627.0 3819.9 3852.5 3860.5 3861.0 3861.2 7296.5 7645.8 7646.6 7668.5 7676.3 7434.5 7472.1 7507.2 7508.8 7526.7 7608.8 7627.5 7630.1 7630.7 7636.4 7023.5 7214.5 7271.9 7277.3 7301.6 7111.7 7170.3 7172.2 7172.9 7201.8 7591.0 7598.3 7609.4 7612.5 7613.6 4572.5 4624.3 4629.3 4632.3 4634.6 6970.8 7238.9 7251.4 7261.0 7262.1 6646.5 7028.4 7045.3 7063.2 7086.1 6201.3 7000.6 7026.1 7027.6 7043.4 5913.6 6586.6 6855.2 6898.3 6902.5 6705.9 7046.3 7054.5 7058.1 7079.2 5757.4 6482.8 6762.5 6769.6 6865.8 02:08:30 INFO - PROCESS | 1664 | 02:08:30 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:18254.31 Median:584.21 stddev:26039.80 (4457.3%) stddev-sans-first:26079.43 02:08:30 INFO - PROCESS | 1664 | Values: 685.0 692.1 731.1 771.7 784.8 15191.8 15278.0 15470.4 15488.6 15499.8 14329.4 14419.0 14456.8 14460.5 14507.0 774.0 774.5 786.1 920.8 942.8 949.5 953.6 956.1 957.5 959.6 1011.0 1017.9 1019.0 1020.7 1024.5 800.0 983.2 1008.5 1009.5 1009.5 743.0 744.2 744.4 745.1 745.3 15238.3 15321.3 15321.9 15325.0 15326.8 12589.7 12622.3 12663.4 12682.6 12968.1 10094.3 10129.3 10274.6 10362.3 11073.2 3518.0 3529.6 3532.8 3551.1 3609.0 66685.0 75509.0 79846.6 80070.6 80300.8 9481.8 9627.8 9677.9 9927.7 9987.7 22316.7 22504.3 22586.7 22633.4 22663.0 7443.2 7475.0 7620.4 7742.8 7865.4 4043.7 4124.2 4143.4 4230.7 4231.0 3070.6 3620.5 3673.3 3690.3 3691.0 633.5 644.9 653.7 653.9 656.7 505.7 551.4 568.2 599.8 620.7 7572.3 7674.4 7776.3 8035.9 8153.1 570.4 579.3 589.1 603.7 605.2 3716.6 3761.2 3803.6 3844.9 4025.7 95121.0 95877.5 96921.5 99064.5 99295.5 77046.0 78166.6 82359.8 82508.6 84359.0 70653.0 70968.0 72013.6 72108.3 72916.0 7648.7 7749.3 7767.4 7781.2 7785.8 49858.5 50812.7 51157.5 51170.5 51261.5 55756.7 59422.9 67520.0 67851.0 70383.6 10151.3 10305.3 10354.9 10451.1 10933.8 10806.0 10809.2 10959.1 11228.1 11381.7 8322.5 9972.0 10135.3 10407.1 10462.6 10375.6 10667.4 10707.5 10761.9 10817.3 9962.3 10110.1 10246.9 10533.3 10784.0 8529.3 8573.4 8624.7 8840.0 8855.5 8546.5 8727.4 8809.6 8981.5 9351.6 02:08:30 INFO - PROCESS | 1664 | -------- Summary: end -------- 02:08:30 INFO - PROCESS | 1664 | 02:08:30 INFO - TEST-INFO | 1664: exit 0 02:08:30 INFO - TEST-OK | dromaeo_css | took 1113407ms 02:08:30 INFO - TEST-START | kraken 02:08:30 INFO - operating with platform_type : mac_ 02:08:30 INFO - Initialising browser for kraken test... 02:08:30 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/tmpZq1VYt/profile http://localhost:49275/getInfo.html) 02:08:33 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 02:08:33 INFO - PROCESS | 1672 | colorDepth:24 02:08:33 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 02:08:33 INFO - PROCESS | 1672 | __metrics 02:08:33 INFO - PROCESS | 1672 | 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" 02:08:33 INFO - PROCESS | 1672 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:08:33 INFO - TEST-INFO | 1672: exit 0 02:08:33 INFO - Browser initialized. 02:08:33 INFO - Running cycle 1/1 for kraken test... 02:08:33 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/tmpZq1VYt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:08:46 INFO - PROCESS | 1674 | RSS: Main: 243818496 02:08:46 INFO - PROCESS | 1674 | 02:08:48 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 02:08:49 INFO - PROCESS | 1674 | RSS: Main: 287924224 02:08:49 INFO - PROCESS | 1674 | 02:08:51 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 02:08:52 INFO - PROCESS | 1674 | RSS: Main: 299474944 02:08:52 INFO - PROCESS | 1674 | 02:08:55 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 02:08:56 INFO - PROCESS | 1674 | RSS: Main: 285315072 02:08:56 INFO - PROCESS | 1674 | 02:08:58 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 02:08:58 INFO - PROCESS | 1674 | RSS: Main: 286412800 02:08:58 INFO - PROCESS | 1674 | 02:09:00 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:09:01 INFO - PROCESS | 1674 | RSS: Main: 286683136 02:09:01 INFO - PROCESS | 1674 | 02:09:04 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 02:09:04 INFO - PROCESS | 1674 | RSS: Main: 290709504 02:09:04 INFO - PROCESS | 1674 | 02:09:07 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 02:09:08 INFO - PROCESS | 1674 | RSS: Main: 287961088 02:09:08 INFO - PROCESS | 1674 | 02:09:10 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 02:09:11 INFO - PROCESS | 1674 | RSS: Main: 288948224 02:09:11 INFO - PROCESS | 1674 | 02:09:12 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:09:13 INFO - PROCESS | 1674 | RSS: Main: 322809856 02:09:13 INFO - PROCESS | 1674 | 02:09:15 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:09:15 INFO - PROCESS | 1674 | RSS: Main: 323592192 02:09:15 INFO - PROCESS | 1674 | 02:09:17 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:09:18 INFO - PROCESS | 1674 | RSS: Main: 331165696 02:09:18 INFO - PROCESS | 1674 | 02:09:21 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:09:21 INFO - PROCESS | 1674 | RSS: Main: 333266944 02:09:21 INFO - PROCESS | 1674 | 02:09:24 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:09:24 INFO - PROCESS | 1674 | RSS: Main: 330907648 02:09:24 INFO - PROCESS | 1674 | 02:09:26 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 02:09:26 INFO - PROCESS | 1674 | RSS: Main: 392941568 02:09:26 INFO - PROCESS | 1674 | 02:09:26 INFO - PROCESS | 1674 | __start_tp_report 02:09:26 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 02:09:26 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 02:09:26 INFO - PROCESS | 1674 | |i|pagename|runs| 02:09:26 INFO - PROCESS | 1674 | |0;ai-astar;112;104;102;109;111;113;114;112;110;110 02:09:26 INFO - PROCESS | 1674 | |1;audio-beat-detection;162;145;174;153;121;141;141;119;161;118 02:09:26 INFO - PROCESS | 1674 | |2;audio-dft;187;183;187;182;182;184;184;181;180;182 02:09:26 INFO - PROCESS | 1674 | |3;audio-fft;78;71;84;78;57;56;57;79;76;56 02:09:26 INFO - PROCESS | 1674 | |4;audio-oscillator;92;95;130;79;79;87;132;114;100;118 02:09:26 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;87;84;87;83;86;84;87;82;86;84 02:09:26 INFO - PROCESS | 1674 | |6;imaging-darkroom;93;93;93;97;92;91;92;92;92;91 02:09:26 INFO - PROCESS | 1674 | |7;imaging-desaturate;93;93;91;89;95;142;94;89;94;87 02:09:26 INFO - PROCESS | 1674 | |8;json-parse-financial;56;54;53;53;53;53;54;63;55;52 02:09:26 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;66;69;66;71;71;68;66;66;69;69 02:09:26 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;83;82;81;83;82;82;83;81;85;83 02:09:26 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;124;135;127;128;112;116;119;119;118;133 02:09:26 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;138;129;139;135;137;128;140;139;137;138 02:09:26 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;66;68;67;68;68;67;68;87;97;93 02:09:26 INFO - PROCESS | 1674 | __end_tp_report 02:09:26 INFO - PROCESS | 1674 | __start_cc_report 02:09:26 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1222 02:09:26 INFO - PROCESS | 1674 | __end_cc_report 02:09:26 INFO - PROCESS | 1674 | __startTimestamp1457431766867__endTimestamp 02:09:26 INFO - PROCESS | 1674 | 02:09:26 INFO - PROCESS | 1674 | ------- Summary: start ------- 02:09:26 INFO - PROCESS | 1674 | Number of tests: 14 02:09:26 INFO - PROCESS | 1674 | 02:09:26 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.50 stddev:3.86 (3.5%) stddev-sans-first:4.00 02:09:26 INFO - PROCESS | 1674 | Values: 112.0 104.0 102.0 109.0 111.0 113.0 114.0 112.0 110.0 110.0 02:09:26 INFO - PROCESS | 1674 | 02:09:26 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:149.00 stddev:19.55 (13.1%) stddev-sans-first:19.56 02:09:26 INFO - PROCESS | 1674 | Values: 162.0 145.0 174.0 153.0 121.0 141.0 141.0 119.0 161.0 118.0 02:09:26 INFO - PROCESS | 1674 | 02:09:26 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:183.20 Median:183.50 stddev:2.35 (1.3%) stddev-sans-first:2.05 02:09:26 INFO - PROCESS | 1674 | Values: 187.0 183.0 187.0 182.0 182.0 184.0 184.0 181.0 180.0 182.0 02:09:26 INFO - PROCESS | 1674 | 02:09:26 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:69.20 Median:77.00 stddev:11.38 (14.8%) stddev-sans-first:11.62 02:09:26 INFO - PROCESS | 1674 | Values: 78.0 71.0 84.0 78.0 57.0 56.0 57.0 79.0 76.0 56.0 02:09:26 INFO - PROCESS | 1674 | 02:09:26 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:79.00 stddev:19.77 (25.0%) stddev-sans-first:20.59 02:09:26 INFO - PROCESS | 1674 | Values: 92.0 95.0 130.0 79.0 79.0 87.0 132.0 114.0 100.0 118.0 02:09:26 INFO - PROCESS | 1674 | 02:09:26 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:85.00 Median:86.00 stddev:1.83 (2.1%) stddev-sans-first:1.79 02:09:26 INFO - PROCESS | 1674 | Values: 87.0 84.0 87.0 83.0 86.0 84.0 87.0 82.0 86.0 84.0 02:09:26 INFO - PROCESS | 1674 | 02:09:26 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:92.60 Median:92.50 stddev:1.71 (1.9%) stddev-sans-first:1.81 02:09:26 INFO - PROCESS | 1674 | Values: 93.0 93.0 93.0 97.0 92.0 91.0 92.0 92.0 92.0 91.0 02:09:26 INFO - PROCESS | 1674 | 02:09:26 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:93.00 stddev:16.13 (17.3%) stddev-sans-first:17.05 02:09:26 INFO - PROCESS | 1674 | Values: 93.0 93.0 91.0 89.0 95.0 142.0 94.0 89.0 94.0 87.0 02:09:26 INFO - PROCESS | 1674 | 02:09:26 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.00 stddev:3.17 (5.9%) stddev-sans-first:3.32 02:09:26 INFO - PROCESS | 1674 | Values: 56.0 54.0 53.0 53.0 53.0 53.0 54.0 63.0 55.0 52.0 02:09:26 INFO - PROCESS | 1674 | 02:09:26 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:69.00 stddev:2.02 (2.9%) stddev-sans-first:2.00 02:09:26 INFO - PROCESS | 1674 | Values: 66.0 69.0 66.0 71.0 71.0 68.0 66.0 66.0 69.0 69.0 02:09:26 INFO - PROCESS | 1674 | 02:09:26 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:1.18 (1.4%) stddev-sans-first:1.24 02:09:26 INFO - PROCESS | 1674 | Values: 83.0 82.0 81.0 83.0 82.0 82.0 83.0 81.0 85.0 83.0 02:09:26 INFO - PROCESS | 1674 | 02:09:26 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:123.10 Median:125.50 stddev:7.55 (6.0%) stddev-sans-first:8.00 02:09:26 INFO - PROCESS | 1674 | Values: 124.0 135.0 127.0 128.0 112.0 116.0 119.0 119.0 118.0 133.0 02:09:26 INFO - PROCESS | 1674 | 02:09:26 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.00 Median:138.00 stddev:4.19 (3.0%) stddev-sans-first:4.38 02:09:26 INFO - PROCESS | 1674 | Values: 138.0 129.0 139.0 135.0 137.0 128.0 140.0 139.0 137.0 138.0 02:09:26 INFO - PROCESS | 1674 | 02:09:26 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:68.00 stddev:12.28 (18.1%) stddev-sans-first:12.59 02:09:26 INFO - PROCESS | 1674 | Values: 66.0 68.0 67.0 68.0 68.0 67.0 68.0 87.0 97.0 93.0 02:09:26 INFO - PROCESS | 1674 | -------- Summary: end -------- 02:09:26 INFO - PROCESS | 1674 | 02:09:27 INFO - TEST-INFO | 1674: exit 0 02:09:27 INFO - TEST-OK | kraken | took 56723ms 02:09:27 INFO - SUITE-END | took 1170s 02:09:28 INFO - Completed test suite (00:19:30) 02:09:28 INFO - javascript benchmark 02:09:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3401.455767077268, 3456.377851986643, 3492.947605785912, 3501.2647344057746, 3524.68277854993, 5505.064139096353, 5594.216809646648, 5611.523020543248, 5632.0, 5661.745221465034, 5584.748686309115, 5653.236813030239, 5669.348024977129, 5731.627444216134, 5750.763585829046, 5066.974665126688, 5092.210707340369, 5137.845864624049, 5141.691498510101, 5237.47625237477, 5217.217417387385, 5217.2695822584865, 5262.973685131588, 5280.419153893069, 5302.549283310923, 5030.82392116276, 5089.05852417304, 5125.077486052528, 5170.379554453452, 5203.869903252449, 5144.125498665198, 5151.665141765773, 5156.74216289184, 5175.637705360627, 5175.9906818170475, 5094.5160209780015, 5109.872253193663, 5123.077845987721, 5143.228515722634, 5188.662736922126, 5446.319210098738, 5523.0, 5551.805686800983, 5557.6109672322955, 5658.886822263573, 6197.442230199304, 6199.752009919643, 6215.595986260879, 6231.844203894893, 6244.687765611701, 6188.350223226541, 6236.812895613139, 6251.374862513758, 6253.062040693887, 6277.560570760049, 5637.520810731093, 5684.4315568443235, 5750.0, 5797.768089276466, 5801.477866991991, 6218.160548326008, 6220.409061139185, 6224.937750622526, 6242.063690446469, 6247.094171345129, 5998.550108741862, 6019.849503762441, 6070.271567411939, 6094.2077529920825, 6100.176476175749, 6092.908606370908, 6149.3235744068115, 6166.969165154235, 6229.345918678564, 6241.126242326078, 6186.845328866724, 6191.071339299051, 6191.102290167901, 6198.969005154945, 6200.0699895015205, 6216.937830621636, 6217.9689101555105, 6218.968905155445, 6220.34686357935, 6235.563510554309, 4776.880577985578, 4820.421549414093, 4854.80580776765, 4859.635527335464, 4866.318715379779, 4371.715838470489, 4394.143142087262, 4416.514183439819, 4430.490493593278, 4430.977845110754, 5634.295713035871, 5638.774449021993, 5642.435756424325, 5647.689377084218, 5661.179129026268, 6159.137720719103, 6163.075538669146, 6176.969115154396, 6246.3753624637175, 6248.687565621701, 5661.915071273934, 5664.320281566238, 5669.036263835158, 5682.602217844794, 5696.943030569641, 5312.893742125213, 5330.840074797762, 5336.626436149432, 5341.359036915517, 5369.221462887859, 6195.19462469876, 6219.160413344141, 6260.686965651699, 6306.684665766602, 6328.810135695937, 6218.782342617987, 6240.53196010292, 6251.374862513712, 6258.0, 6259.718312676032, 6192.102145189013, 6234.314225435108, 6240.12638230639, 6260.499160067275, 6267.9373206267355, 6097.827165393427, 6120.0, 6156.322804491413, 6165.568410211422, 6194.907076393948, 6233.096201050913, 6239.469645080219, 6246.969250073687, 6254.562180647493, 6260.373962603703, 4303.483581970058, 5892.499137573182, 6009.54928380382, 6070.757169713162, 6105.9694701526205, 6036.849078773066, 6069.605475644069, 6076.361981991828, 6097.969510152599, 6123.938760612336, 5848.181254624441, 5892.292924849045, 5898.380670029585, 5914.201582786441, 5928.170056192223, 5880.470757631662, 6017.849553761191, 6071.787487437919, 6075.149479072845, 6082.178905847654, 5882.617629854046, 5904.0, 5913.645181289136, 5919.437653422918, 5929.495992840657], "unit": "score", "name": "dojo.html", "value": 5658.100550590437}, {"lowerIsBetter": false, "replicates": [493.50402845140604, 507.53828972559023, 549.8460431079296, 626.9968650156749, 637.5696404926675, 37718.62281377186, 38647.80676096619, 38795.418068728955, 38872.0, 38894.72158062611, 43147.0, 43625.47310844113, 43631.99999999992, 43723.0, 44028.55971440284, 9583.664571740008, 9814.656487022956, 9819.950900245489, 9827.066428689262, 9830.754231144243, 8582.399232053758, 9328.020557841397, 9714.028597140301, 9882.752931176707, 9893.752656183617, 9822.803543929118, 9897.356671816346, 9899.15857152143, 9906.05892440217, 9929.90070099297, 9798.167155791767, 9873.160781333523, 9875.555599998017, 9877.753056173582, 9878.851817222747, 9606.471644059575, 9744.75638109046, 9748.561314740853, 9748.561314740853, 9749.36629119105, 40329.596704032876, 40627.78116656475, 40632.59367406317, 40645.390319145234, 40696.59303406958, 3269.75476839238, 3305.93388132236, 3446.4141096013736, 3465.094198190985, 3893.3186692329014, 27950.16149515518, 29480.410391792044, 29496.557551636743, 29545.40909181826, 29603.555946660817, 2700.1494529223232, 2838.0066976558246, 2873.396586716792, 2884.2645125493073, 2973.018903761775, 481524.0, 484401.0, 484423.0, 484802.0, 485024.14975850494, 66987.29646090664, 67374.0, 67380.0, 67389.0, 67499.66250168816, 70924.0, 71054.93417598741, 71066.64466677634, 71187.28812711807, 71353.28646713571, 15471.22643867802, 17211.31154753796, 17465.21406536709, 17488.30046798114, 17496.65006699884, 11717.765644687059, 11771.587994420326, 11781.0, 11792.29246245228, 13295.401706923212, 16608.508268976642, 22537.549249014926, 22730.659040114413, 22842.54314913726, 22904.312870613907, 8337.624806883705, 9823.508824558743, 9951.601935922627, 10073.517284808337, 10093.69718908434, 955.8231727130503, 976.72651657536, 1004.8593196952286, 1061.0238580505952, 1096.9890301097046, 27573.0, 28174.71825281762, 28295.575566366522, 29062.85481959677, 29307.413851722846, 911.9635214591342, 1060.4379678770265, 1090.0571006079842, 1131.4682099413262, 1146.9655910322704, 14514.056586321854, 14885.553433396799, 15008.774868376982, 15009.324580393908, 15640.296186671627, 537015.0, 627893.0, 631952.0, 634726.0, 637348.0, 57462.85074298574, 59849.700751496835, 60449.488762781286, 60624.09063864045, 60705.0, 1360.5986234060977, 1492.149474799354, 1512.0096336899348, 1513.8561836625504, 1631.796025496813, 25769.71151442458, 26672.733272667025, 28326.43347133087, 28527.42945141127, 28688.856555717088, 44950.325745114504, 45477.772611138054, 45703.314450283935, 45754.0, 45772.54227457816, 331687.0, 333826.0, 334512.0, 334971.0, 489092.0, 32872.671273286964, 33833.66166338305, 33858.32283354369, 33877.83061084679, 33895.66104339024, 40325.39511907382, 41294.38058429186, 41333.79333103315, 41441.96395090147, 41897.0, 34918.65081349255, 34959.30081398409, 34981.47527787034, 35501.0, 35659.82170089237, 33827.81602643896, 34056.0, 34353.14117147091, 34376.0, 34677.0, 34351.65648343485, 34571.65428345785, 34861.0, 35172.0, 35219.47170792492, 30191.0, 30515.08454746361, 30602.693973059984, 30610.92861749828, 30817.537736933515, 22242.0, 23322.183723569593, 23491.295261142193, 23725.406864828517, 23772.0], "unit": "score", "name": "ext.html", "value": 19797.469512079228}, {"lowerIsBetter": false, "replicates": [361.30448885894646, 363.23357715220885, 364.37691547453846, 369.37944253653865, 374.00887647733487, 17114.486565403044, 19859.503512412197, 21075.367738967816, 21103.6834447483, 21132.788672113293, 12420.254784712924, 17085.974841509516, 20908.26821061263, 21771.891140544314, 21773.891130544365, 5202.921956170651, 5431.619786614919, 5484.341878974528, 5489.451054894518, 5490.780368785264, 4287.356896465524, 4458.1306645204195, 5330.733463326837, 7171.282871712813, 7682.654280557388, 7369.410447164214, 7642.082950045974, 7651.426143039266, 7660.693572257103, 7684.807879802994, 7602.315791578757, 7656.770296891103, 7678.616069196546, 7685.730999415049, 7686.846263074764, 4479.596836284717, 4505.7296562206375, 7207.423406127497, 7224.349808517206, 7310.597917114556, 27040.323991900164, 27857.58213626797, 29062.564061539095, 29360.0, 29443.41113177746, 2242.2264318809985, 2351.2240960483, 2792.2042217967783, 2938.61797966263, 3271.084096452997, 14805.555833325017, 15525.378984840592, 15572.221388930508, 15804.051756894623, 16465.753013704805, 1819.9909000455045, 1907.3419670213755, 1907.8473722102199, 1938.030984507746, 1946.5912158446743, 119632.0, 123916.38041809824, 125199.0, 125472.37263813714, 129413.35293323472, 18895.14971826271, 19468.610627787366, 19746.605067898563, 19772.20911163566, 19788.60422791565, 29536.261593459905, 29539.261518462212, 29572.852135739184, 29611.703882961327, 29615.85192074069, 8857.247133993682, 10638.893611063944, 10996.890031099747, 11049.060829829554, 11125.777484450266, 9383.202427793714, 9401.623935042659, 9424.858627120599, 9480.573374198178, 9540.570674319672, 8239.382046346547, 8658.874346334936, 8705.738827835175, 8874.733757987271, 8890.777730556787, 2874.3532705141174, 3521.2781379817075, 3562.717421728176, 3597.37046016946, 3641.9635803642154, 870.525563567857, 927.3276874266103, 959.1367769007949, 994.8209322322051, 1070.341739829999, 17517.562060948578, 19593.902030489757, 19910.303139390053, 20548.184793743658, 20653.896730516553, 946.0775743649887, 946.8816397950256, 963.4123184857232, 992.2508506078009, 1003.4581326083979, 10931.56273749041, 11197.104231661448, 11197.328160310408, 11200.495977681025, 11220.495077721522, 604253.5108462583, 604707.0, 610758.0, 613458.0, 624068.0, 112931.0, 120727.39636301938, 131208.0, 132347.0, 134261.0, 1033.9069483746348, 1059.3379138038727, 1076.8169411200115, 1077.7682798198425, 1080.2168427889717, 18202.0, 18431.170597322885, 18578.81421185771, 18894.716579251046, 19068.427947161606, 33431.832840836614, 33728.458511855904, 40360.79819600883, 47525.20760675123, 54805.0, 74961.6251918737, 75574.0, 75989.0, 76949.2305076942, 78485.0, 7947.245011723877, 8035.799105022187, 8079.717209897625, 8174.0, 8391.370647201362, 8640.56797160127, 9487.33588648788, 12049.0, 13255.337233138498, 13675.111117777313, 8133.2680058794995, 8165.183481652025, 8196.098429172906, 8342.580651611208, 11481.540738370371, 7597.506162099446, 7777.144514103331, 8190.385721071063, 8263.297619702393, 8283.83432331338, 7473.43949203801, 8339.0, 8375.37184711137, 8633.481991080555, 8643.222110010129, 11626.418679065844, 11820.0, 11937.16439849237, 12000.912843308502, 12139.0, 10616.044555989998, 11283.097352211638, 11895.717541685159, 12108.152429329863, 12121.939390302992], "unit": "score", "name": "jquery.html", "value": 10504.154635308}, {"lowerIsBetter": false, "replicates": [1420.3111490926892, 1545.0883978452712, 1563.1480842940596, 1843.4838245291323, 2012.4365177750235, 7986.121526632066, 8491.193336633018, 8611.526366049864, 8624.655013799456, 8636.784080397993, 7358.859376796591, 8426.494410335385, 8654.783630409227, 8691.043985161627, 8718.0, 2182.519845633958, 2246.629306164481, 2251.8536295140843, 2468.568000599901, 2505.24842547236, 2048.2319130326127, 2488.4322876587726, 2512.510060538196, 2513.1078467144175, 2517.672702548666, 2423.587990041697, 2433.1605596069326, 2437.9878100609562, 2472.307753828931, 2481.280428675691, 2475.492524032587, 2488.4276616378243, 2494.837835540693, 2496.425822060927, 2527.1155095716535, 2425.4057755849753, 2445.572024895654, 2447.657327974085, 2453.4234454903085, 2457.299669594157, 8863.556822158931, 8886.155815197546, 8901.198892099677, 8905.154010369004, 8917.55412229386, 5367.838964831061, 5503.642263252876, 5539.14143307788, 5548.667079975215, 5569.610127291091, 2963.0, 3143.921401964946, 3600.747947643666, 3724.1992971511254, 3724.7951362675312, 1059.1420949031233, 1069.0485467933545, 1072.072657151566, 1080.9082826345368, 1088.2110469909333, 12013.459394327276, 12044.39778011096, 12058.577949771803, 12080.939595302056, 12150.696232594168, 4865.513448655177, 4917.9918116785975, 4942.061008408391, 4957.3059771632, 4990.10178167926, 10228.64199753005, 10254.692359229235, 10256.435896025641, 10266.845997310047, 10335.741606459898, 5537.086380747212, 5545.251391062155, 5549.667019978814, 5552.278203833475, 5568.276124103922, 3582.2119133790525, 4583.679142459996, 4765.809367625326, 5028.647994640413, 5040.672356296829, 3931.6264954829244, 3965.0682089708894, 3973.562908080109, 4014.8394064237687, 4020.4170395292517, 1305.6866352075433, 1313.7306852095298, 1314.3756715560032, 1324.4172564071778, 1325.6221976736583, 1335.052112999781, 1338.4779935825036, 1351.236551348485, 1396.2250950722243, 1397.2943663450096, 7219.711211551584, 7993.400494962901, 8086.919130808734, 8133.959330203429, 8137.349012079019, 522.5218924683948, 523.1316015414394, 526.4104203292337, 529.9125644268653, 533.5704757670113, 6141.723622436912, 6161.537884658668, 6175.228096487939, 6194.38056194386, 6207.81376558704, 10534.051935325857, 10886.074683651977, 10890.727731806768, 10899.83650245247, 10900.454977251105, 10365.170786337076, 10640.201984851166, 10655.360678359324, 10701.143908487302, 10748.032677058945, 8216.178382161735, 8334.874976875473, 8371.162883711702, 8374.581270936429, 8379.952505936757, 7753.069631644239, 7916.564588947663, 7918.564478953483, 8039.959800201195, 8048.919510804817, 9379.484128372733, 9517.23862091045, 9545.856812147962, 9739.561719722487, 9768.413895166028, 9703.0, 9937.900620993987, 9987.250956178461, 10094.343867648578, 10099.545520451451, 6759.222689390586, 6783.4573234142135, 7149.356557909813, 7535.962320188364, 7598.962005189938, 8122.187781221831, 8153.6738530458115, 8190.50856948585, 8196.672133114847, 8212.425130240827, 7191.784246472404, 7296.96351518239, 7300.0, 7382.704691812267, 7478.850422991619, 7220.819479513054, 7231.168415632059, 7312.4881258313535, 7347.375473084634, 7370.078740157481, 7735.33690256575, 7818.179091195342, 7819.609019549113, 7830.569318687527, 7836.529808211526, 6887.690053947485, 6975.407090397373, 7081.150261968597, 7084.22073571917, 7084.36240738336, 7127.964360178374, 7196.4962452627815, 7199.8560028800175, 7216.675249613885, 7219.819504512429], "unit": "score", "name": "mootools.html", "value": 4844.925657964022}, {"lowerIsBetter": false, "replicates": [322.6644289938464, 326.97711160218796, 330.5058936889348, 331.30260801013856, 337.0209541282575, 6532.216134063913, 6573.276939536653, 6602.1417215761885, 6629.436497897673, 6656.833579160523, 6546.149000629912, 6560.147180866481, 6567.8358041049, 6568.244651865037, 6591.879380505314, 4617.746023968681, 4714.622830173578, 4729.787159577827, 4867.342908707333, 4898.216285394329, 4827.131116399047, 4829.299751536025, 4842.2252439609665, 4864.829730959417, 4884.120858245515, 3900.7854567998747, 4350.15172041452, 4354.47746270448, 4795.808167673306, 4824.758762061901, 4601.953980460203, 4690.226112691419, 4784.904301913943, 4804.543568361, 4819.325294458778, 4101.8974525636795, 4105.281575724236, 4110.0, 4112.3420252759415, 4125.0, 6250.937490625081, 6291.339409361997, 6301.180846489973, 6308.148399965991, 6316.715747791361, 5719.857003574903, 5742.483176514133, 5752.482276595127, 5753.482186603226, 5756.1653560233535, 6674.098996635489, 6860.965695171542, 6929.965350173217, 6945.652717364112, 6950.826229344257, 4664.673472856902, 4680.485146633868, 4691.390119284471, 4691.741954192518, 4704.294355846616, 7271.3092256236105, 7315.963420182865, 7334.643091028177, 7349.669264883093, 7351.77944661661, 4754.857354279377, 4758.262469317261, 4759.1671457495495, 4762.976185119052, 4778.617710583145, 4823.0, 4824.155772739827, 4830.347903033045, 4836.806527738921, 4845.466998630148, 5725.627834190765, 5728.971355143198, 5742.397048309867, 5744.712764361765, 5750.1949727038245, 6625.635590042498, 6999.965000174967, 7004.318963448735, 7005.0893383859775, 7034.50758446914, 1654.544001278867, 1661.5015495351588, 1678.9580260493342, 1679.1520282257627, 1681.6048228666255, 1019.0980981830985, 1056.6196169379018, 1086.766345235778, 1095.2114477576133, 1120.675004248775, 5869.735861886225, 6355.650439225795, 6418.19772528434, 6418.8716225675225, 6494.675266236669, 7316.926830731731, 7327.8534429312185, 7328.743493977685, 7341.5405839044515, 7345.706171753177, 6594.769183078569, 6606.834829129214, 6616.768413105615, 6623.4701223901975, 6627.0, 3819.923601527954, 3852.499175107218, 3860.478835357247, 3861.0, 3861.189150278473, 7296.525725827804, 7645.770626881203, 7646.617669116522, 7668.539887606761, 7676.270754278335, 7434.479586428898, 7472.103347598214, 7507.249275072449, 7508.774736757906, 7526.736564220336, 7608.771736847903, 7627.466077374531, 7630.122535908331, 7630.694772209049, 7636.449051191223, 7023.508065320137, 7214.494985350975, 7271.890921636285, 7277.345038946309, 7301.561906285639, 7111.6799744010605, 7170.282971702788, 7172.211056783645, 7172.928270717226, 7201.819954501179, 7591.0, 7598.278163574451, 7609.353204977639, 7612.467127301035, 7613.581253031137, 4572.542745725401, 4624.260118381043, 4629.328747331685, 4632.328312394751, 4634.629229661687, 6970.79087627372, 7238.855222895408, 7251.383632391306, 7260.96369518149, 7262.055932728711, 6646.501512386687, 7028.402585780062, 7045.330693584101, 7063.1524217094275, 7086.078809754699, 6201.255849298113, 7000.579965202104, 7026.086608740831, 7027.648617569203, 7043.401310888632, 5913.615614985184, 6586.604803711793, 6855.211650660238, 6898.344657257552, 6902.516823822284, 6705.932940670531, 7046.260142684944, 7054.541454805421, 7058.11773528309, 7079.1505019398, 5757.424257574209, 6482.837929051623, 6762.4928130389435, 6769.593824370553, 6865.794026179223], "unit": "score", "name": "prototype.html", "value": 5138.562306779247}, {"lowerIsBetter": false, "replicates": [685.0375222811949, 692.1244625548678, 731.1043971135358, 771.7453240430658, 784.823414731685, 15191.772123418157, 15278.006929549572, 15470.38118475261, 15488.612784680388, 15499.767503487443, 14329.426822927071, 14419.0, 14456.783148252785, 14460.493882714107, 14506.984511084229, 774.0363247756551, 774.4501404003164, 786.0724345272577, 920.8158368326344, 942.8491441369382, 949.5299826585815, 953.594722243044, 956.1251454918742, 957.4733896356976, 959.5825815770128, 1011.009210973243, 1017.8982101789836, 1019.0217391304357, 1020.6835880876952, 1024.549198352726, 800.0039950261903, 983.1593987141034, 1008.5108722269694, 1009.5002973528151, 1009.5305682857506, 742.9925700742978, 744.2185705009719, 744.437949348244, 745.117036311972, 745.3403737692181, 15238.314275857612, 15321.310541025681, 15321.850861185456, 15325.003874748105, 15326.770098448533, 12589.74820503594, 12622.305773182472, 12663.430145643468, 12682.61952141428, 12968.092233543655, 10094.29339946204, 10129.290949633529, 10274.640387586398, 10362.27464077515, 11073.169512286611, 3518.032541051206, 3529.5764508258917, 3532.7527073104893, 3551.058969373118, 3608.9639103608893, 66684.99972500416, 75509.0, 79846.60076699637, 80070.59964700197, 80300.79548806831, 9481.762955926019, 9627.759306017406, 9677.854832177523, 9927.652532161339, 9987.650432234837, 22316.665250021262, 22504.32487025392, 22586.661200082013, 22633.4341641457, 22663.0, 7443.181250062489, 7475.028246328051, 7620.3522700569965, 7742.845143097219, 7865.41009424284, 4043.6562892153906, 4124.1957818225155, 4143.440635514167, 4230.682698797541, 4230.957690423056, 3070.570120183176, 3620.456931460302, 3673.2653469306247, 3690.317291301118, 3691.003429074135, 633.5241518670578, 644.8742495213482, 653.7254353171584, 653.8823011857911, 656.7143292667705, 505.71427143663715, 551.4154995704566, 568.2470726287686, 599.8040244276613, 620.6586377492451, 7572.318491335806, 7674.42441816866, 7776.261255180749, 8035.879461808077, 8153.103158652543, 570.3912387905712, 579.2932622200908, 589.1310317281975, 603.728322254987, 605.2102006881063, 3716.6097559756377, 3761.153740408386, 3803.581606023335, 3844.8654297100024, 4025.6578190854107, 95121.0, 95877.52061239649, 96921.51539242259, 99064.51403228957, 99295.51056734155, 77046.0, 78166.6091669538, 82359.76460353099, 82508.58745706233, 84359.0, 70653.0, 70968.0, 72013.63993180105, 72108.27891721121, 72915.99999999894, 7648.694052237848, 7749.263819937097, 7767.417443691858, 7781.182975787461, 7785.805354866174, 49858.50141498539, 50812.729681758254, 51157.48842511527, 51170.48829511657, 51261.46215613538, 55756.72121639366, 59422.92019779287, 67520.0, 67851.0, 70383.64808175927, 10151.289409741246, 10305.330153539995, 10354.948225258826, 10451.059404653617, 10933.83599245996, 10806.0, 10809.243352965217, 10959.12327013821, 11228.10175185967, 11381.715457113638, 8322.45904016237, 9972.0, 10135.290529662852, 10407.06336429725, 10462.63380781669, 10375.584976600852, 10667.413292269, 10707.518161682587, 10761.892381076403, 10817.296875703054, 9962.252831037556, 10110.090091891765, 10246.948765256424, 10533.315334503233, 10784.0, 8529.317654587494, 8573.356998225034, 8624.741257762276, 8840.0, 8855.512946787989, 8546.529940853312, 8727.432716873383, 8809.559522023745, 8981.506017169118, 9351.625934962525], "unit": "score", "name": "yui.html", "value": 6843.077947129195}], "name": "dromaeo_css", "value": 7650.26454609962}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 104.0, 102.0, 109.0, 111.0, 113.0, 114.0, 112.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [162.0, 145.0, 174.0, 153.0, 121.0, 141.0, 141.0, 119.0, 161.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 143.5}, {"lowerIsBetter": true, "replicates": [187.0, 183.0, 187.0, 182.0, 182.0, 184.0, 184.0, 181.0, 180.0, 182.0], "unit": "score", "name": "audio-dft", "value": 183.2}, {"lowerIsBetter": true, "replicates": [78.0, 71.0, 84.0, 78.0, 57.0, 56.0, 57.0, 79.0, 76.0, 56.0], "unit": "score", "name": "audio-fft", "value": 69.2}, {"lowerIsBetter": true, "replicates": [92.0, 95.0, 130.0, 79.0, 79.0, 87.0, 132.0, 114.0, 100.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 102.6}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 87.0, 83.0, 86.0, 84.0, 87.0, 82.0, 86.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.0}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 93.0, 97.0, 92.0, 91.0, 92.0, 92.0, 92.0, 91.0], "unit": "score", "name": "imaging-darkroom", "value": 92.6}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 91.0, 89.0, 95.0, 142.0, 94.0, 89.0, 94.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 53.0, 53.0, 53.0, 53.0, 54.0, 63.0, 55.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.6}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 66.0, 71.0, 71.0, 68.0, 66.0, 66.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 81.0, 83.0, 82.0, 82.0, 83.0, 81.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [124.0, 135.0, 127.0, 128.0, 112.0, 116.0, 119.0, 119.0, 118.0, 133.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.1}, {"lowerIsBetter": true, "replicates": [138.0, 129.0, 139.0, 135.0, 137.0, 128.0, 140.0, 139.0, 137.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.0}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 67.0, 68.0, 68.0, 67.0, 68.0, 87.0, 97.0, 93.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 74.9}], "name": "kraken", "value": 1421.7}]} 02:09:28 INFO - Return code: 0 02:09:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:09:28 INFO - # TBPL SUCCESS # 02:09:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:09:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:09:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:09:28 INFO - 2016-03-08 02:09:28.138 screenresolution[1678:9592] starting screenresolution argv=screenresolution get 02:09:28 INFO - 2016-03-08 02:09:28.140 screenresolution[1678:9592] Display 0: 1600x1200x32@60 02:09:28 INFO - 2016-03-08 02:09:28.146 screenresolution[1679:9595] starting screenresolution argv=screenresolution list 02:09:28 INFO - Available Modes on Display 0 02:09:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:09:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:09:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:09:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:09:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:09:28 INFO - Intel Iris: 02:09:28 INFO - Chipset Model: Intel Iris 02:09:28 INFO - Type: GPU 02:09:28 INFO - Bus: Built-In 02:09:28 INFO - VRAM (Dynamic, Max): 1536 MB 02:09:28 INFO - Vendor: Intel (0x8086) 02:09:28 INFO - Device ID: 0x0a2e 02:09:28 INFO - Revision ID: 0x0009 02:09:28 INFO - Displays: 02:09:28 INFO - Display: 02:09:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:09:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:09:28 INFO - Display Serial Number: 1600x1200 60 02:09:28 INFO - Main Display: Yes 02:09:28 INFO - Mirror: Off 02:09:28 INFO - Online: Yes 02:09:28 INFO - Rotation: Supported 02:09:28 INFO - Return code: 0 02:09:28 INFO - Running post-action listener: _resource_record_post_action 02:09:28 INFO - Running post-run listener: _resource_record_post_run 02:09:29 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 39106048; Write bytes: 704554496; Read time: 427; Write time: 1967 02:09:29 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 406643200; Write bytes: 403940864; Read time: 29990; Write time: 793 02:09:29 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 31956480; Write bytes: 298901504; Read time: 335; Write time: 1167 02:09:29 INFO - Running post-run listener: _upload_blobber_files 02:09:29 INFO - Blob upload gear active. 02:09:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:09:29 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 02:09:29 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'] 02:09:29 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 02:09:29 INFO - (blobuploader) - INFO - Open directory for files ... 02:09:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:09:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:09:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:09:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:09:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:09:31 INFO - (blobuploader) - INFO - Done attempting. 02:09:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:09:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:09:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:09:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:09:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:09:32 INFO - (blobuploader) - INFO - Done attempting. 02:09:32 INFO - (blobuploader) - INFO - Iteration through files over. 02:09:32 INFO - Return code: 0 02:09:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:09:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:09:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c02eb57858651cbc5917133a5858a1de5dde06d9b300b6128cbaee7454ef45f41878e39624ddf94f42cc699e2016e217870a9b14f913cbcad1b23c7271cb86b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62865ce456217406e80f208b3b0b7f35be10275a0ed32fe4fa096b5b201daf853be2648128547733f3e2219d58936f34e51039478fdbb284fc0a7187adda6e84"} 02:09:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:09:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:09:32 INFO - Contents: 02:09:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c02eb57858651cbc5917133a5858a1de5dde06d9b300b6128cbaee7454ef45f41878e39624ddf94f42cc699e2016e217870a9b14f913cbcad1b23c7271cb86b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62865ce456217406e80f208b3b0b7f35be10275a0ed32fe4fa096b5b201daf853be2648128547733f3e2219d58936f34e51039478fdbb284fc0a7187adda6e84"} 02:09:32 INFO - Running post-run listener: copy_logs_to_upload_dir 02:09:32 INFO - Copying logs to upload dir... 02:09:32 INFO - mkdir: /builds/slave/test/build/upload/logs 02:09:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.286878 ========= master_lag: 0.89 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-03-08 02:09:33.611188) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-08 02:09:33.612342) ========= 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.MEHc2FmTVZ/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.6sXRocbcx7/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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/c02eb57858651cbc5917133a5858a1de5dde06d9b300b6128cbaee7454ef45f41878e39624ddf94f42cc699e2016e217870a9b14f913cbcad1b23c7271cb86b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62865ce456217406e80f208b3b0b7f35be10275a0ed32fe4fa096b5b201daf853be2648128547733f3e2219d58936f34e51039478fdbb284fc0a7187adda6e84"} build_url:https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011180 build_url: 'https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c02eb57858651cbc5917133a5858a1de5dde06d9b300b6128cbaee7454ef45f41878e39624ddf94f42cc699e2016e217870a9b14f913cbcad1b23c7271cb86b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62865ce456217406e80f208b3b0b7f35be10275a0ed32fe4fa096b5b201daf853be2648128547733f3e2219d58936f34e51039478fdbb284fc0a7187adda6e84"}' ========= master_lag: 1.88 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-08 02:09:35.498715) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-03-08 02:09:35.499025) ========= 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.MEHc2FmTVZ/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.6sXRocbcx7/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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.005477 ========= master_lag: 4.37 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-03-08 02:09:39.878646) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 02:09:39.878956) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 02:09:40.154240) ========= ========= Total master_lag: 7.31 =========