builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0179 starttime: 1457664263.39 results: success (0) buildid: 20160310175616 builduid: 14fb84ee01af47f7a5e16d9a816fd8f4 revision: 8db798e8974a2e906d5b9958f945749285731a39 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 18:44:23.394299) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 18:44:23.394787) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 18:44:23.395148) ========= 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.41Aya2muIQ/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.Guccp1gQ2z/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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.005640 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 18:44:23.421959) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 18:44:23.422291) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 18:44:23.438857) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 18:44:23.439197) ========= 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.41Aya2muIQ/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.Guccp1gQ2z/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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.005204 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 18:44:23.487443) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 18:44:23.487760) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 18:44:23.488113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 18:44:23.488389) ========= 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.41Aya2muIQ/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.Guccp1gQ2z/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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-10 18:44:23-- 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% 45.9M=0s 2016-03-10 18:44:23 (45.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156464 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 18:44:23.664579) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 18:44:23.664915) ========= 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.41Aya2muIQ/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.Guccp1gQ2z/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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.017817 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 18:44:23.714375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-10 18:44:23.714737) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8db798e8974a2e906d5b9958f945749285731a39 --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 8db798e8974a2e906d5b9958f945749285731a39 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.41Aya2muIQ/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.Guccp1gQ2z/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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-10 18:44:23,790 truncating revision to first 12 chars 2016-03-10 18:44:23,790 Setting DEBUG logging. 2016-03-10 18:44:23,790 attempt 1/10 2016-03-10 18:44:23,790 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8db798e8974a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-10 18:44:25,136 unpacking tar archive at: mozilla-aurora-8db798e8974a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.595806 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-10 18:44:25.331845) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 18:44:25.332209) ========= echo 8db798e8974a2e906d5b9958f945749285731a39 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8db798e8974a2e906d5b9958f945749285731a39'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.41Aya2muIQ/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.Guccp1gQ2z/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 8db798e8974a2e906d5b9958f945749285731a39 program finished with exit code 0 elapsedTime=0.004863 script_repo_revision: '8db798e8974a2e906d5b9958f945749285731a39' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 18:44:25.385197) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 18:44:25.385525) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 18:44:25.399108) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-03-10 18:44:25.399452) ========= /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.41Aya2muIQ/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.Guccp1gQ2z/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 18:44:25 INFO - MultiFileLogger online at 20160310 18:44:25 in /builds/slave/test 18:44:25 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 18:44:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:44:25 INFO - {'append_to_log': False, 18:44:25 INFO - 'base_work_dir': '/builds/slave/test', 18:44:25 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:44:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:44:25 INFO - 'branch': 'Mozilla-Aurora', 18:44:25 INFO - 'buildbot_json_path': 'buildprops.json', 18:44:25 INFO - 'config_files': ('talos/mac_config.py',), 18:44:25 INFO - 'default_actions': ('clobber', 18:44:25 INFO - 'read-buildbot-config', 18:44:25 INFO - 'download-and-extract', 18:44:25 INFO - 'populate-webroot', 18:44:25 INFO - 'create-virtualenv', 18:44:25 INFO - 'install', 18:44:25 INFO - 'run-tests'), 18:44:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:44:25 INFO - 'download_minidump_stackwalk': True, 18:44:25 INFO - 'download_symbols': 'ondemand', 18:44:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:44:25 INFO - 'tooltool.py': '/tools/tooltool.py', 18:44:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:44:25 INFO - '/tools/misc-python/virtualenv.py')}, 18:44:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:44:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:44:25 INFO - 'installer_path': 'installer.exe', 18:44:25 INFO - 'log_level': 'info', 18:44:25 INFO - 'log_name': 'talos', 18:44:25 INFO - 'log_to_console': True, 18:44:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:44:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:44:25 INFO - 'opt_config_files': (), 18:44:25 INFO - 'pip_index': False, 18:44:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:44:25 INFO - 'cmd': ('bash', 18:44:25 INFO - '-c', 18:44:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:44:25 INFO - 'enabled': True, 18:44:25 INFO - 'halt_on_failure': False, 18:44:25 INFO - 'name': 'check_screen_resolution'},), 18:44:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:44:25 INFO - 'cmd': ('bash', 18:44:25 INFO - '-c', 18:44:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:44:25 INFO - 'enabled': True, 18:44:25 INFO - 'halt_on_failure': False, 18:44:25 INFO - 'name': 'check_screen_resolution'},), 18:44:25 INFO - 'run_cmd_checks_enabled': True, 18:44:25 INFO - 'sps_profile': False, 18:44:25 INFO - 'sps_profile_interval': 0, 18:44:25 INFO - 'suite': 'dromaeojs', 18:44:25 INFO - 'system_bits': '32', 18:44:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:44:25 INFO - 'title': 't-yosemite-r7-0179', 18:44:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:44:25 INFO - 'use_talos_json': True, 18:44:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:44:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:44:25 INFO - 'work_dir': 'build'} 18:44:25 INFO - ##### 18:44:25 INFO - ##### Running clobber step. 18:44:25 INFO - ##### 18:44:25 INFO - Running pre-action listener: _resource_record_pre_action 18:44:25 INFO - Running main action method: clobber 18:44:25 INFO - rmtree: /builds/slave/test/build 18:44:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:44:27 INFO - Running post-action listener: _resource_record_post_action 18:44:27 INFO - ##### 18:44:27 INFO - ##### Running read-buildbot-config step. 18:44:27 INFO - ##### 18:44:27 INFO - Running pre-action listener: _resource_record_pre_action 18:44:27 INFO - Running main action method: read_buildbot_config 18:44:27 INFO - Using buildbot properties: 18:44:27 INFO - { 18:44:27 INFO - "project": "", 18:44:27 INFO - "product": "firefox", 18:44:27 INFO - "script_repo_revision": "production", 18:44:27 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 18:44:27 INFO - "repository": "", 18:44:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 18:44:27 INFO - "buildid": "20160310175616", 18:44:27 INFO - "pgo_build": "False", 18:44:27 INFO - "basedir": "/builds/slave/test", 18:44:27 INFO - "buildnumber": 119, 18:44:27 INFO - "slavename": "t-yosemite-r7-0179", 18:44:27 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:44:27 INFO - "platform": "yosemite_r7", 18:44:27 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 18:44:27 INFO - "branch": "mozilla-aurora", 18:44:27 INFO - "repo_path": "releases/mozilla-aurora", 18:44:27 INFO - "revision": "8db798e8974a2e906d5b9958f945749285731a39", 18:44:27 INFO - "stage_platform": "macosx64", 18:44:27 INFO - "builduid": "14fb84ee01af47f7a5e16d9a816fd8f4", 18:44:27 INFO - "slavebuilddir": "test" 18:44:27 INFO - } 18:44:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 18:44:27 INFO - Running post-action listener: _resource_record_post_action 18:44:27 INFO - ##### 18:44:27 INFO - ##### Running download-and-extract step. 18:44:27 INFO - ##### 18:44:27 INFO - Running pre-action listener: _resource_record_pre_action 18:44:27 INFO - Running main action method: download_and_extract 18:44:27 INFO - mkdir: /builds/slave/test/build/tests 18:44:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:27 INFO - https://queue.taskcluster.net/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:44:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 18:44:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 18:44:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 18:44:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 18:44:28 INFO - Downloaded 1277 bytes. 18:44:28 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 18:44:28 INFO - Using the following test package requirements: 18:44:28 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 18:44:28 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:44:28 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 18:44:28 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:44:28 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 18:44:28 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:44:28 INFO - u'jsshell-mac.zip'], 18:44:28 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:44:28 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 18:44:28 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 18:44:28 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:44:28 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 18:44:28 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:44:28 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 18:44:28 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:44:28 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 18:44:28 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 18:44:28 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:44:28 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 18:44:28 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 18:44: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')]} 18:44:28 INFO - https://queue.taskcluster.net/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:44:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 18:44:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 18:44:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 18:44:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:44:32 INFO - Downloaded 17864658 bytes. 18:44:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:44:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:44:35 INFO - Return code: 0 18:44:35 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 18:44:35 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')]} 18:44:35 INFO - https://queue.taskcluster.net/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:44:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 18:44:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 18:44:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 18:44:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:44:36 INFO - Downloaded 17864658 bytes. 18:44:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:44:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:44:39 INFO - Return code: 0 18:44: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')]} 18:44:39 INFO - https://queue.taskcluster.net/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:44:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 18:44:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 18:44:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 18:44:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 18:44:40 INFO - Downloaded 10845161 bytes. 18:44:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:44:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 18:44:40 INFO - Return code: 0 18:44:40 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')]} 18:44:40 INFO - https://queue.taskcluster.net/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 18:44:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 18:44:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 18:44:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 18:44:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 18:44:44 INFO - Downloaded 114972338 bytes. 18:44:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 18:44:44 INFO - mkdir: /builds/slave/test/properties 18:44:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:44:44 INFO - Writing to file /builds/slave/test/properties/build_url 18:44:44 INFO - Contents: 18:44:44 INFO - build_url:https://queue.taskcluster.net/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 18:44:45 INFO - Running post-action listener: _resource_record_post_action 18:44:45 INFO - Running post-action listener: set_extra_try_arguments 18:44:45 INFO - ##### 18:44:45 INFO - ##### Running populate-webroot step. 18:44:45 INFO - ##### 18:44:45 INFO - Running pre-action listener: _resource_record_pre_action 18:44:45 INFO - Running main action method: populate_webroot 18:44:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:44:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:44:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:44:45 INFO - '--tppagecycles', 18:44:45 INFO - '7'], 18:44:45 INFO - 'tests': ['tsvgm']}}, 18:44:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:44:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:44:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:44:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:44:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:44:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:44:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:44:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:45 INFO - 'talos_options': ['--e10s'], 18:44:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:44:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:45 INFO - 'tests': ['damp', 'tps']}, 18:44:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:45 INFO - 'talos_options': ['--e10s'], 18:44:45 INFO - 'tests': ['damp', 'tps']}, 18:44:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:44:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:44:45 INFO - 'other': {'tests': ['a11yr', 18:44:45 INFO - 'ts_paint', 18:44:45 INFO - 'tpaint', 18:44:45 INFO - 'sessionrestore', 18:44:45 INFO - 'sessionrestore_no_auto_restore', 18:44:45 INFO - 'tabpaint']}, 18:44:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:44:45 INFO - 'tests': ['a11yr', 18:44:45 INFO - 'ts_paint', 18:44:45 INFO - 'tpaint', 18:44:45 INFO - 'sessionrestore', 18:44:45 INFO - 'sessionrestore_no_auto_restore', 18:44:45 INFO - 'tabpaint']}, 18:44:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:44:45 INFO - 'tests': ['a11yr', 18:44:45 INFO - 'ts_paint', 18:44:45 INFO - 'tpaint', 18:44:45 INFO - 'sessionrestore', 18:44:45 INFO - 'sessionrestore_no_auto_restore', 18:44:45 INFO - 'tabpaint']}, 18:44:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:44:45 INFO - 'tests': ['a11yr', 18:44:45 INFO - 'ts_paint', 18:44:45 INFO - 'tpaint', 18:44:45 INFO - 'sessionrestore', 18:44:45 INFO - 'sessionrestore_no_auto_restore', 18:44:45 INFO - 'tabpaint']}, 18:44:45 INFO - 'other_l64': {'tests': ['a11yr', 18:44:45 INFO - 'ts_paint', 18:44:45 INFO - 'tpaint', 18:44:45 INFO - 'sessionrestore', 18:44:45 INFO - 'sessionrestore_no_auto_restore', 18:44:45 INFO - 'tabpaint']}, 18:44:45 INFO - 'other_nol64': {'tests': ['a11yr', 18:44:45 INFO - 'ts_paint', 18:44:45 INFO - 'tpaint', 18:44:45 INFO - 'sessionrestore', 18:44:45 INFO - 'sessionrestore_no_auto_restore', 18:44:45 INFO - 'tabpaint']}, 18:44:45 INFO - 'svgr': {'tests': ['tsvgx', 18:44:45 INFO - 'tsvgr_opacity', 18:44:45 INFO - 'tart', 18:44:45 INFO - 'tscrollx', 18:44:45 INFO - 'cart']}, 18:44:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:44:45 INFO - 'tests': ['tsvgx', 18:44:45 INFO - 'tsvgr_opacity', 18:44:45 INFO - 'tart', 18:44:45 INFO - 'tscrollx', 18:44:45 INFO - 'cart']}, 18:44:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:45 INFO - 'tests': ['tp5o']}, 18:44:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:45 INFO - 'talos_options': ['--e10s'], 18:44:45 INFO - 'tests': ['tp5o']}, 18:44:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:45 INFO - 'talos_options': ['--xperf_path', 18:44:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:44:45 INFO - 'tests': ['tp5n']}, 18:44:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:45 INFO - 'talos_options': ['--e10s', 18:44:45 INFO - '--xperf_path', 18:44:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:44:45 INFO - 'tests': ['tp5n']}}, 18:44:45 INFO - 'talos.zip': {'path': '', 18:44:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:44:45 INFO - Running post-action listener: _resource_record_post_action 18:44:45 INFO - ##### 18:44:45 INFO - ##### Running create-virtualenv step. 18:44:45 INFO - ##### 18:44:45 INFO - Running pre-action listener: _resource_record_pre_action 18:44:45 INFO - Running main action method: create_virtualenv 18:44:45 INFO - Creating virtualenv /builds/slave/test/build/venv 18:44:45 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 18:44:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:44:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:44:45 INFO - Using real prefix '/tools/python27' 18:44:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:44:45 INFO - Installing distribute.............................................................................................................................................................................................done. 18:44:48 INFO - Installing pip.................done. 18:44:48 INFO - Return code: 0 18:44:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:48 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 0x108bbba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9352c9bc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a5fd30>, '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 0x1088c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a56b20>, '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.41Aya2muIQ/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.Guccp1gQ2z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 18:44:48 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 18:44:48 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 18:44:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41Aya2muIQ/Render', 18:44:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:44:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:44:48 INFO - 'HOME': '/Users/cltbld', 18:44:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:44:48 INFO - 'LOGNAME': 'cltbld', 18:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:48 INFO - 'MOZ_NO_REMOTE': '1', 18:44:48 INFO - 'NO_EM_RESTART': '1', 18:44:48 INFO - 'PAGER': '/bin/cat', 18:44:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:48 INFO - 'PWD': '/builds/slave/test', 18:44:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:44:48 INFO - 'SHELL': '/bin/bash', 18:44:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Guccp1gQ2z/Listeners', 18:44:48 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 18:44:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:44:48 INFO - 'USER': 'cltbld', 18:44:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:44:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:48 INFO - 'XPC_FLAGS': '0x0', 18:44:48 INFO - 'XPC_SERVICE_NAME': '0', 18:44:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:44:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:49 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 18:44:49 INFO - Cleaning up... 18:44:49 INFO - Return code: 0 18:44:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:49 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 0x108bbba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9352c9bc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a5fd30>, '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 0x1088c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a56b20>, '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.41Aya2muIQ/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.Guccp1gQ2z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 18:44:49 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 18:44:49 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 18:44:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41Aya2muIQ/Render', 18:44:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:44:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:44:49 INFO - 'HOME': '/Users/cltbld', 18:44:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:44:49 INFO - 'LOGNAME': 'cltbld', 18:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:49 INFO - 'MOZ_NO_REMOTE': '1', 18:44:49 INFO - 'NO_EM_RESTART': '1', 18:44:49 INFO - 'PAGER': '/bin/cat', 18:44:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:49 INFO - 'PWD': '/builds/slave/test', 18:44:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:44:49 INFO - 'SHELL': '/bin/bash', 18:44:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Guccp1gQ2z/Listeners', 18:44:49 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 18:44:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:44:49 INFO - 'USER': 'cltbld', 18:44:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:44:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:49 INFO - 'XPC_FLAGS': '0x0', 18:44:49 INFO - 'XPC_SERVICE_NAME': '0', 18:44:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:44:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:49 INFO - Downloading/unpacking psutil>=0.7.1 18:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:44:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:44:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:44:52 INFO - Installing collected packages: psutil 18:44:52 INFO - Running setup.py install for psutil 18:44:52 INFO - building 'psutil._psutil_osx' extension 18:44:52 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 18:44:52 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 18:44:52 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 18:44:52 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 18:44:52 INFO - building 'psutil._psutil_posix' extension 18:44:52 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 18:44:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:44:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:44:52 INFO - ^ 18:44:52 INFO - 1 warning generated. 18:44:52 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 18:44:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:44:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:44:53 INFO - Successfully installed psutil 18:44:53 INFO - Cleaning up... 18:44:53 INFO - Return code: 0 18:44:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:44:53 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')]} 18:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:53 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')]} 18:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:53 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 0x108bbba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9352c9bc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a5fd30>, '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 0x1088c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a56b20>, '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.41Aya2muIQ/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.Guccp1gQ2z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 18:44:53 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 18:44:53 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 18:44:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41Aya2muIQ/Render', 18:44:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:44:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:44:53 INFO - 'HOME': '/Users/cltbld', 18:44:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:44:53 INFO - 'LOGNAME': 'cltbld', 18:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:53 INFO - 'MOZ_NO_REMOTE': '1', 18:44:53 INFO - 'NO_EM_RESTART': '1', 18:44:53 INFO - 'PAGER': '/bin/cat', 18:44:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:53 INFO - 'PWD': '/builds/slave/test', 18:44:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:44:53 INFO - 'SHELL': '/bin/bash', 18:44:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Guccp1gQ2z/Listeners', 18:44:53 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 18:44:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:44:53 INFO - 'USER': 'cltbld', 18:44:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:44:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:53 INFO - 'XPC_FLAGS': '0x0', 18:44:53 INFO - 'XPC_SERVICE_NAME': '0', 18:44:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:44:53 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 18:44:53 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 18:44:53 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 18:44:53 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 18:44:53 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 18:44:53 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 18:44:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:44:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:44:55 INFO - Installing collected packages: mozsystemmonitor 18:44:55 INFO - Running setup.py install for mozsystemmonitor 18:44:55 INFO - Successfully installed mozsystemmonitor 18:44:55 INFO - Cleaning up... 18:44:55 INFO - Return code: 0 18:44:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:44: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')]} 18:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44: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')]} 18:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44: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', '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 0x108bbba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9352c9bc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a5fd30>, '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 0x1088c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a56b20>, '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.41Aya2muIQ/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.Guccp1gQ2z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 18:44: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:44: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 blobuploader==1.2.4 18:44:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41Aya2muIQ/Render', 18:44:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:44:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:44:55 INFO - 'HOME': '/Users/cltbld', 18:44:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:44:55 INFO - 'LOGNAME': 'cltbld', 18:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:55 INFO - 'MOZ_NO_REMOTE': '1', 18:44:55 INFO - 'NO_EM_RESTART': '1', 18:44:55 INFO - 'PAGER': '/bin/cat', 18:44:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:55 INFO - 'PWD': '/builds/slave/test', 18:44:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:44:55 INFO - 'SHELL': '/bin/bash', 18:44:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Guccp1gQ2z/Listeners', 18:44:55 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 18:44:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:44:55 INFO - 'USER': 'cltbld', 18:44:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:44:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:55 INFO - 'XPC_FLAGS': '0x0', 18:44:55 INFO - 'XPC_SERVICE_NAME': '0', 18:44:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:44:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:56 INFO - Downloading/unpacking blobuploader==1.2.4 18:44:56 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 18:44:56 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 18:44:56 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 18:44:56 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 18:44:56 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 18:44:56 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 18:44:59 INFO - Downloading blobuploader-1.2.4.tar.gz 18:44:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:44:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:45:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45:00 INFO - Downloading docopt-0.6.1.tar.gz 18:45:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:45:00 INFO - Installing collected packages: blobuploader, requests, docopt 18:45:00 INFO - Running setup.py install for blobuploader 18:45:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:45:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:45:00 INFO - Running setup.py install for requests 18:45:01 INFO - Running setup.py install for docopt 18:45:01 INFO - Successfully installed blobuploader requests docopt 18:45:01 INFO - Cleaning up... 18:45:01 INFO - Return code: 0 18:45:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:01 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 0x108bbba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9352c9bc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a5fd30>, '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 0x1088c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a56b20>, '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.41Aya2muIQ/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.Guccp1gQ2z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 18:45:01 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 18:45:01 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 18:45:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41Aya2muIQ/Render', 18:45:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:45:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:45:01 INFO - 'HOME': '/Users/cltbld', 18:45:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:45:01 INFO - 'LOGNAME': 'cltbld', 18:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:01 INFO - 'MOZ_NO_REMOTE': '1', 18:45:01 INFO - 'NO_EM_RESTART': '1', 18:45:01 INFO - 'PAGER': '/bin/cat', 18:45:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:01 INFO - 'PWD': '/builds/slave/test', 18:45:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:45:01 INFO - 'SHELL': '/bin/bash', 18:45:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Guccp1gQ2z/Listeners', 18:45:01 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 18:45:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:45:01 INFO - 'USER': 'cltbld', 18:45:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:45:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:01 INFO - 'XPC_FLAGS': '0x0', 18:45:01 INFO - 'XPC_SERVICE_NAME': '0', 18:45:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:45:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:45:01 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-5ZeqwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:45:02 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-GjuWga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:45:02 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-jOnTOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:45:02 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-OPLxSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:45:02 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-QShPgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:45:02 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-TNwa5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:45:02 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-s1OfEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:45:02 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-40Ssfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:45:02 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-x0vppT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:45:02 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-VhlN5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:45:02 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-YgYlap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:45:03 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-C9hL8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:45:03 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-B1u4j2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:45:03 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-y4PYmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:03 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-7NAZO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:45:03 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-cmiYk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:45:03 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-cKy7jS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:45:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:45:03 INFO - Running setup.py install for manifestparser 18:45:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:45:03 INFO - Running setup.py install for mozcrash 18:45:03 INFO - Running setup.py install for mozdebug 18:45:04 INFO - Running setup.py install for mozdevice 18:45:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:45:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:45:04 INFO - Running setup.py install for mozfile 18:45:04 INFO - Running setup.py install for mozhttpd 18:45:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:45:04 INFO - Running setup.py install for mozinfo 18:45:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:45:04 INFO - Running setup.py install for mozInstall 18:45:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:45:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:45:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:45:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:45:04 INFO - Running setup.py install for mozleak 18:45:04 INFO - Running setup.py install for mozlog 18:45:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:45:05 INFO - Running setup.py install for moznetwork 18:45:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:45:05 INFO - Running setup.py install for mozprocess 18:45:05 INFO - Running setup.py install for mozprofile 18:45:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:45:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:45:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:45:05 INFO - Running setup.py install for mozrunner 18:45:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:45:05 INFO - Running setup.py install for mozscreenshot 18:45:05 INFO - Running setup.py install for moztest 18:45:06 INFO - Running setup.py install for mozversion 18:45:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:45:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:45:06 INFO - Cleaning up... 18:45:06 INFO - Return code: 0 18:45:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:06 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 0x108bbba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9352c9bc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a5fd30>, '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 0x1088c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a56b20>, '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.41Aya2muIQ/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.Guccp1gQ2z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 18:45:06 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 18:45:06 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 18:45:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41Aya2muIQ/Render', 18:45:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:45:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:45:06 INFO - 'HOME': '/Users/cltbld', 18:45:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:45:06 INFO - 'LOGNAME': 'cltbld', 18:45:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:06 INFO - 'MOZ_NO_REMOTE': '1', 18:45:06 INFO - 'NO_EM_RESTART': '1', 18:45:06 INFO - 'PAGER': '/bin/cat', 18:45:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:45:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:06 INFO - 'PWD': '/builds/slave/test', 18:45:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:45:06 INFO - 'SHELL': '/bin/bash', 18:45:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Guccp1gQ2z/Listeners', 18:45:06 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 18:45:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:45:06 INFO - 'USER': 'cltbld', 18:45:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:45:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:45:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:06 INFO - 'XPC_FLAGS': '0x0', 18:45:06 INFO - 'XPC_SERVICE_NAME': '0', 18:45:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:45:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:45:06 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-1WdacA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:45:06 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)) 18:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:45:06 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-5wx5th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:45:06 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)) 18:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:45:06 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-GTydoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:45:06 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)) 18:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:45:06 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-MFG1ZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:45:06 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)) 18:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:45:06 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-VET814-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:45:07 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)) 18:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:45:07 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-1xbQT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:45:07 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)) 18:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:45:07 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-dZGiPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:45:07 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)) 18:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:45:07 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-nE6dGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:45:07 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)) 18:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:45:07 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-TRgFZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:45:07 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)) 18:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:45:07 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-q9H0Mj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:45:07 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)) 18:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:45:07 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-4QdOy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:45:07 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)) 18:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:45:07 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-GsUoiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:45:07 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)) 18:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:45:07 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-OyeCKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:45:07 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)) 18:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:45:07 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-djwFf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:45:07 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)) 18:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:07 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-ikrQDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:08 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)) 18:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:45:08 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-FN31Go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:45:08 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)) 18:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:45:08 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-Gt73tT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:45:08 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)) 18:45:08 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)) 18:45:08 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)) 18:45:08 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)) 18:45:08 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)) 18:45:08 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)) 18:45:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:10 INFO - Downloading blessings-1.6.tar.gz 18:45:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:45:10 INFO - Installing collected packages: blessings 18:45:10 INFO - Running setup.py install for blessings 18:45:10 INFO - Successfully installed blessings 18:45:10 INFO - Cleaning up... 18:45:10 INFO - Return code: 0 18:45:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:45:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:45:11 INFO - Reading from file tmpfile_stdout 18:45:11 INFO - Current package versions: 18:45:11 INFO - blessings == 1.6 18:45:11 INFO - blobuploader == 1.2.4 18:45:11 INFO - docopt == 0.6.1 18:45:11 INFO - manifestparser == 1.1 18:45:11 INFO - mozInstall == 1.12 18:45:11 INFO - mozcrash == 0.17 18:45:11 INFO - mozdebug == 0.1 18:45:11 INFO - mozdevice == 0.48 18:45:11 INFO - mozfile == 1.2 18:45:11 INFO - mozhttpd == 0.7 18:45:11 INFO - mozinfo == 0.9 18:45:11 INFO - mozleak == 0.1 18:45:11 INFO - mozlog == 3.1 18:45:11 INFO - moznetwork == 0.27 18:45:11 INFO - mozprocess == 0.22 18:45:11 INFO - mozprofile == 0.28 18:45:11 INFO - mozrunner == 6.11 18:45:11 INFO - mozscreenshot == 0.1 18:45:11 INFO - mozsystemmonitor == 0.0 18:45:11 INFO - moztest == 0.7 18:45:11 INFO - mozversion == 1.4 18:45:11 INFO - psutil == 3.1.1 18:45:11 INFO - requests == 1.2.3 18:45:11 INFO - wsgiref == 0.1.2 18:45:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:45:11 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')]} 18:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:11 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')]} 18:45:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:11 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 0x108bbba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9352c9bc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a5fd30>, '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 0x1088c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a56b20>, '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.41Aya2muIQ/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.Guccp1gQ2z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 18:45:11 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 18:45:11 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 18:45:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41Aya2muIQ/Render', 18:45:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:45:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:45:11 INFO - 'HOME': '/Users/cltbld', 18:45:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:45:11 INFO - 'LOGNAME': 'cltbld', 18:45:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:11 INFO - 'MOZ_NO_REMOTE': '1', 18:45:11 INFO - 'NO_EM_RESTART': '1', 18:45:11 INFO - 'PAGER': '/bin/cat', 18:45:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:45:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:11 INFO - 'PWD': '/builds/slave/test', 18:45:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:45:11 INFO - 'SHELL': '/bin/bash', 18:45:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Guccp1gQ2z/Listeners', 18:45:11 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 18:45:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:45:11 INFO - 'USER': 'cltbld', 18:45:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:45:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:45:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:11 INFO - 'XPC_FLAGS': '0x0', 18:45:11 INFO - 'XPC_SERVICE_NAME': '0', 18:45:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:45:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:11 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)) 18:45:11 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)) 18:45:11 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)) 18:45:11 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)) 18:45:11 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)) 18:45:11 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)) 18:45:11 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)) 18:45:11 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)) 18:45:11 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)) 18:45:11 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)) 18:45:11 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)) 18:45:11 INFO - Cleaning up... 18:45:11 INFO - Return code: 0 18:45:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:45:11 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')]} 18:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:11 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')]} 18:45:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:11 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 0x108bbba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9352c9bc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a5fd30>, '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 0x1088c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a56b20>, '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.41Aya2muIQ/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.Guccp1gQ2z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 18:45:11 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 18:45:11 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 18:45:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41Aya2muIQ/Render', 18:45:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:45:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:45:11 INFO - 'HOME': '/Users/cltbld', 18:45:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:45:11 INFO - 'LOGNAME': 'cltbld', 18:45:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:11 INFO - 'MOZ_NO_REMOTE': '1', 18:45:11 INFO - 'NO_EM_RESTART': '1', 18:45:11 INFO - 'PAGER': '/bin/cat', 18:45:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:45:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:11 INFO - 'PWD': '/builds/slave/test', 18:45:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:45:11 INFO - 'SHELL': '/bin/bash', 18:45:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Guccp1gQ2z/Listeners', 18:45:11 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 18:45:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:45:11 INFO - 'USER': 'cltbld', 18:45:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:45:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:45:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:11 INFO - 'XPC_FLAGS': '0x0', 18:45:11 INFO - 'XPC_SERVICE_NAME': '0', 18:45:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:45:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:11 INFO - Downloading/unpacking jsonschema 18:45:11 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 18:45:11 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 18:45:11 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 18:45:11 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 18:45:11 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 18:45:11 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 18:45:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:45:14 INFO - Downloading/unpacking functools32 (from jsonschema) 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45:14 INFO - Downloading functools32-3.2.3-2.tar.gz 18:45:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:45:14 INFO - warning: no files found matching '*.txt' 18:45:14 INFO - no previously-included directories found matching 'build' 18:45:14 INFO - no previously-included directories found matching 'dist' 18:45:14 INFO - no previously-included directories found matching '.git*' 18:45:14 INFO - Installing collected packages: jsonschema, functools32 18:45:14 INFO - Running setup.py install for functools32 18:45:14 INFO - warning: no files found matching '*.txt' 18:45:14 INFO - no previously-included directories found matching 'build' 18:45:14 INFO - no previously-included directories found matching 'dist' 18:45:14 INFO - no previously-included directories found matching '.git*' 18:45:14 INFO - Successfully installed jsonschema functools32 18:45:14 INFO - Cleaning up... 18:45:14 INFO - Return code: 0 18:45:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:14 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 0x108bbba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9352c9bc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a5fd30>, '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 0x1088c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a56b20>, '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.41Aya2muIQ/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.Guccp1gQ2z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 18:45:14 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 18:45:14 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 18:45:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41Aya2muIQ/Render', 18:45:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:45:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:45:14 INFO - 'HOME': '/Users/cltbld', 18:45:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:45:14 INFO - 'LOGNAME': 'cltbld', 18:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:14 INFO - 'MOZ_NO_REMOTE': '1', 18:45:14 INFO - 'NO_EM_RESTART': '1', 18:45:14 INFO - 'PAGER': '/bin/cat', 18:45:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:14 INFO - 'PWD': '/builds/slave/test', 18:45:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:45:14 INFO - 'SHELL': '/bin/bash', 18:45:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Guccp1gQ2z/Listeners', 18:45:14 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 18:45:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:45:14 INFO - 'USER': 'cltbld', 18:45:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:45:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:14 INFO - 'XPC_FLAGS': '0x0', 18:45:14 INFO - 'XPC_SERVICE_NAME': '0', 18:45:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:15 INFO - Downloading/unpacking flake8 18:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:45:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:45:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:45:18 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 18:45:18 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 18:45:18 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 18:45:18 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 18:45:18 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 18:45:18 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 18:45:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:45:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:45:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:45:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:45:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:45:18 INFO - no previously-included directories found matching 'docs/_build' 18:45:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:45:18 INFO - Running setup.py install for pep8 18:45:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:45:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:45:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:45:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:45:18 INFO - no previously-included directories found matching 'docs/_build' 18:45:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:45:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:45:18 INFO - Cleaning up... 18:45:18 INFO - Return code: 0 18:45:18 INFO - Running post-action listener: _resource_record_post_action 18:45:18 INFO - Running post-action listener: _start_resource_monitoring 18:45:18 INFO - Starting resource monitoring. 18:45:18 INFO - ##### 18:45:18 INFO - ##### Running install step. 18:45:18 INFO - ##### 18:45:18 INFO - Running pre-action listener: _resource_record_pre_action 18:45:18 INFO - Running main action method: install 18:45:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:45:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:45:19 INFO - Reading from file tmpfile_stdout 18:45:19 INFO - Detecting whether we're running mozinstall >=1.0... 18:45:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:45:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:45:19 INFO - Reading from file tmpfile_stdout 18:45:19 INFO - Output received: 18:45:19 INFO - Usage: mozinstall [options] installer 18:45:19 INFO - Options: 18:45:19 INFO - -h, --help show this help message and exit 18:45:19 INFO - -d DEST, --destination=DEST 18:45:19 INFO - Directory to install application into. [default: 18:45:19 INFO - "/builds/slave/test"] 18:45:19 INFO - --app=APP Application being installed. [default: firefox] 18:45:19 INFO - mkdir: /builds/slave/test/build/application 18:45:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:45:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 18:45:52 INFO - Reading from file tmpfile_stdout 18:45:52 INFO - Output received: 18:45:52 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 18:45:52 INFO - Running post-action listener: _resource_record_post_action 18:45:52 INFO - ##### 18:45:52 INFO - ##### Running run-tests step. 18:45:52 INFO - ##### 18:45:52 INFO - Running pre-action listener: _resource_record_pre_action 18:45:52 INFO - Running main action method: run_tests 18:45:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:45:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:45:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:45:52 INFO - 2016-03-10 18:45:52.022 screenresolution[1935:10360] starting screenresolution argv=screenresolution get 18:45:52 INFO - 2016-03-10 18:45:52.024 screenresolution[1935:10360] Display 0: 1600x1200x32@60 18:45:52 INFO - 2016-03-10 18:45:52.029 screenresolution[1936:10362] starting screenresolution argv=screenresolution list 18:45:52 INFO - Available Modes on Display 0 18:45:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:45:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:45:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:45:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:45:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:45:52 INFO - Intel Iris: 18:45:52 INFO - Chipset Model: Intel Iris 18:45:52 INFO - Type: GPU 18:45:52 INFO - Bus: Built-In 18:45:52 INFO - VRAM (Dynamic, Max): 1536 MB 18:45:52 INFO - Vendor: Intel (0x8086) 18:45:52 INFO - Device ID: 0x0a2e 18:45:52 INFO - Revision ID: 0x0009 18:45:52 INFO - Displays: 18:45:52 INFO - Display: 18:45:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:45:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:45:52 INFO - Display Serial Number: 1600x1200 60 18:45:52 INFO - Main Display: Yes 18:45:52 INFO - Mirror: Off 18:45:52 INFO - Online: Yes 18:45:52 INFO - Rotation: Supported 18:45:52 INFO - Return code: 0 18:45:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:45:52 INFO - Python 2.7.3 18:45:52 INFO - Return code: 0 18:45:52 INFO - grabbing minidump binary from tooltool 18:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:52 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 0x108a5fd30>, '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 0x1088c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a56b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:45:52 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 18:45:52 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 18:45:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:45:52 INFO - Return code: 0 18:45:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:45:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:45:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:45:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:45:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:45:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:45:53 INFO - Return code: 0 18:45:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0179', '--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 18:45:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0179 --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 18:45:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41Aya2muIQ/Render', 18:45:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:45:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:45:53 INFO - 'HOME': '/Users/cltbld', 18:45:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:45:53 INFO - 'LOGNAME': 'cltbld', 18:45:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:45:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:53 INFO - 'MOZ_NO_REMOTE': '1', 18:45:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:45:53 INFO - 'NO_EM_RESTART': '1', 18:45:53 INFO - 'PAGER': '/bin/cat', 18:45:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:53 INFO - 'PWD': '/builds/slave/test', 18:45:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:45:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:45:53 INFO - 'SHELL': '/bin/bash', 18:45:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Guccp1gQ2z/Listeners', 18:45:53 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 18:45:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:45:53 INFO - 'USER': 'cltbld', 18:45:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:45:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:53 INFO - 'XPC_FLAGS': '0x0', 18:45:53 INFO - 'XPC_SERVICE_NAME': '0', 18:45:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:45:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0179', '--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 18:45:53 INFO - mozversion application_buildid: 20160310175616 18:45:53 INFO - mozversion application_changeset: 8db798e8974a2e906d5b9958f945749285731a39 18:45:53 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:45:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:45:53 INFO - mozversion application_name: Firefox 18:45:53 INFO - mozversion application_remotingname: firefox-dev 18:45:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:45:53 INFO - mozversion application_vendor: Mozilla 18:45:53 INFO - mozversion application_version: 47.0a2 18:45:53 INFO - mozversion platform_buildid: 20160310175616 18:45:53 INFO - mozversion platform_changeset: 8db798e8974a2e906d5b9958f945749285731a39 18:45:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:45:53 INFO - mozversion platform_version: 47.0a2 18:45:53 INFO - using testdate: 1457664353 18:45:53 INFO - actual date: 1457664353 18:45:53 INFO - starting webserver on 'localhost:49488' 18:45:53 INFO - SUITE-START | Running 2 tests 18:45:53 INFO - TEST-START | dromaeo_css 18:45:53 INFO - operating with platform_type : mac_ 18:45:53 INFO - Initialising browser for dromaeo_css test... 18:45:53 INFO - TEST-INFO | started process 1954 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/tmpCVGk2v/profile http://localhost:49488/getInfo.html) 18:45:55 INFO - PROCESS | 1954 | __metrics Screen width/height:1600/1200 18:45:55 INFO - PROCESS | 1954 | colorDepth:24 18:45:55 INFO - PROCESS | 1954 | Browser inner width/height: 1024/689 18:45:55 INFO - PROCESS | 1954 | __metrics 18:45:56 INFO - PROCESS | 1954 | 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" 18:45:56 INFO - PROCESS | 1954 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:45:56 INFO - TEST-INFO | 1954: exit 0 18:45:56 INFO - Browser initialized. 18:45:56 INFO - Running cycle 1/1 for dromaeo_css test... 18:45:56 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/tmpCVGk2v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:46:08 INFO - PROCESS | 1956 | RSS: Main: 210620416 18:46:08 INFO - PROCESS | 1956 | 18:46:59 INFO - PROCESS | 1956 | 1457664419713 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] 18:49:09 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49488/tests/dromaeo/cssquery-ext.html) 18:49:11 INFO - PROCESS | 1956 | RSS: Main: 328712192 18:49:11 INFO - PROCESS | 1956 | 18:52:13 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-ext.html (next: http://localhost:49488/tests/dromaeo/cssquery-jquery.html) 18:52:14 INFO - PROCESS | 1956 | RSS: Main: 339451904 18:52:14 INFO - PROCESS | 1956 | 18:55:16 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49488/tests/dromaeo/cssquery-mootools.html) 18:55:16 INFO - PROCESS | 1956 | RSS: Main: 349306880 18:55:16 INFO - PROCESS | 1956 | 18:58:18 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49488/tests/dromaeo/cssquery-prototype.html) 18:58:19 INFO - PROCESS | 1956 | RSS: Main: 307236864 18:58:19 INFO - PROCESS | 1956 | 19:01:22 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49488/tests/dromaeo/cssquery-yui.html) 19:01:22 INFO - PROCESS | 1956 | RSS: Main: 304824320 19:01:22 INFO - PROCESS | 1956 | 19:04:25 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-yui.html (next: http://localhost:49488/tests/dromaeo/cssquery-dojo.html) 19:04:25 INFO - PROCESS | 1956 | RSS: Main: 373194752 19:04:25 INFO - PROCESS | 1956 | 19:04:25 INFO - PROCESS | 1956 | __start_tp_report 19:04:25 INFO - PROCESS | 1956 | _x_x_mozilla_page_load 19:04:25 INFO - PROCESS | 1956 | _x_x_mozilla_page_load_details 19:04:25 INFO - PROCESS | 1956 | |i|pagename|runs| 19:04:25 INFO - PROCESS | 1956 | |0;dojo.html;3422.229998250394;3518.5425894633695;3520.964790352096;3521.6830485256323;3568.1258091767504;5924.526037916967;5935.643861368321;5946.464818166364;5949.553783466241;5960.672163031037;5902.439268269508;5943.613665111765;5966.105084237367;5968.432998865101;5976.19321391612;5148.202028685541;5216.113260745673;5223.869403264911;5242.528172464477;5290.1800220965615;5279.996800607892;5288.180332048539;5290.497402746752;5292.073887069767;5299.364076310848;5219.582433405338;5274.498922602365;5298.867528311785;5302.257683924254;5310.230016647583;5278.868028299285;5327.920081198785;5332.253484512191;5339.038972984861;5341.919871201935;5037.420696619899;5262.552683021948;5263.552598029172;5275.472452754732;5277.102892508283;5618.381977982419;5728.283964504437;5743.913841292384;5757.798477053283;5768.6250393724695;6194.5044396448175;6279.183706118175;6279.340669229757;6286.654234017127;6298.559100862942;5280.3663560373;6241.438270555672;6274.843128921813;6305;6339.8415039623915;6006.669633170174;6013.308469525973;6036.094585812163;6041.426064523863;6083.057126145454;6251.531135164881;6347.682615869188;6380.617162970237;6398.9040164397575;6400.423961843457;6285.120083188357;6298.1812364392335;6306.968465157736;6308.905366419507;6311.990081586924;6301;6301.306856245809;6303.842403939847;6316.905246421307;6333.493320534346;6131.866048757567;6184.103305020747;6271.466925311308;6275.623462592259;6300.905486417708;5275.709835959059;6237.563370564108;6262.1859158310035;6262.812115636538;6283.3088360280335;4973.726445045557;4991.575716064102;4992.500749924979;4996.325496057985;5029.77498900925;4448.1770872388715;4456.420665313489;4540.614047805908;4555.544445555484;4562.110388474216;5795.710214489259;5826.592138550345;5840.853978650568;5840.88318233633;5875.735591898375;6313.96843015782;6328.493720502349;6338.524610654127;6343.5876668016435;6344.809655710336;5652.349979752299;5807.796727114615;5819.912701309484;5839.708014599338;5872.530197584183;5436.6194366393975;5448.83653490396;5464.480874316933;5476.151196564539;5483.698396588226;6440.677966101583;6454.290028096905;6481.513886458534;6508.967455162694;6519.967400162969;6216.813495595139;6282.2147231596055;6296.307406185224;6337.176167098248;6381.904271435839;6442.871142577029;6451.645159516084;6465.64438955862;6474.870502590016;6485.546011779319;6172.845678857885;6269.68651567429;6294.590851594632;6294.716737746904;6295.653739044396;6234.501239900887;6276.560640755286;6290.402411770874;6307.936920630918;6311.27420346666;6226.159468471698;6265.122882796503;6265.185525881606;6276.1213430118905;6282;6102.7253773579405;6135.202044401795;6244.5316601256;6256.311805701278;6283.905741413974;5980.671063091398;6107.735039974475;6131.356207598316;6171.6297022178815;6172.105044768573;6242.188515492957;6262.311145774052;6282.591631543935;6287.308396076336;6291.748330066746;6015.639061656315;6044.637321760532;6138.07928810682;6150.200473938538;6156.384361563808 19:04:25 INFO - PROCESS | 1956 | |1;ext.html;500.3795293835645;595.4432605513842;621.4034526854219;649.7855707616486;661.4113439039256;31584.68415315846;32018.039458816216;32063;32063.877764278255;32093.51859722103;35134.82432587833;42308.153836923244;42727;42749.57250427495;42815.14369712604;9787.755306117333;9978.550965206583;9984.95007524965;9986;9997.750056248615;9741.464219467927;9887.90112098877;9890.06044425782;9891.060349266843;9892.604295828158;9849.310548261625;9922.652707155252;9931.957144499831;9934.950325248363;10036.548355324028;9930.602775888956;9993;10004.54979525923;10025.949870250675;10032.097111259949;8873.29013678904;9621.615135394575;9849.507524623812;9972.650957216463;9987.850182247272;43067.13865722668;43350.56649433497;43381.78309108466;43409.782951085355;43416.56583434157;3222.6455089940087;3341.6992470677756;3382.1206486313736;3713.851445942159;3927.3912543555793;30024.69975300241;30069.097927062223;30079.849600752073;30084.69915300841;30609.846950765328;2788.762955148815;2811.9437611247863;2857.8571071446345;2878.309205790616;2890.8174328382147;374644;374667;375123;375510.99999999726;375522;69870.65064674644;70402;70418.29581704117;70484;70497.64751176212;65818.67090664516;74598.50802984019;78957.81563276556;80229.59885200537;80338.59830700808;15153.54539363821;18396.26414943414;18407.355742548945;18638.254469821328;18650.16074276661;13875.791863122062;13978.580642580739;13988;14002.22987735664;14003;23028.19401320979;23243.883780581327;23335.649965250534;23337.18319858797;23363.53272934532;9159.336265493856;9375.578098985561;9387.765305867271;9400.529973501298;9410.623575056921;965.7151140413595;990.4354517924713;1005.9748506287401;1084.6583326252362;1122.9949195470008;27729.730533431764;28119.32866377691;29376.559351609314;30218.697813021587;30740.077797666105;1106.1040557148735;1160.0893298760432;1161.6689243565543;1186.9703257418462;1230.8830661087181;15465.458708945132;15537.922310388376;15555.611109722122;15614.45349412765;15777.605559861095;554462;558983;560454.3954560403;561354.3864561383;563714;62068.689656551425;63725.36274637287;63802;63810;63839;1366.3100134432048;1391.9860801392058;1462.7878957551095;1487.4570781664615;1521.1709618258076;29495.85252073726;29866;29919.55120673235;30412.93554725574;30640.84679576588;48428.789280268276;48554.514454855;49026;49055;49167.50832491629;387612;387854;388016;388266;388472;30643.693563064084;32194;35133.47299790556;35684.92945211648;36152.096197595274;43242.783786080865;43913.121737564434;44302.33546496741;44854.55145448504;45390.865228369556;35503.93488195358;36820;36830.8158459206;36923;37504.87485375443;35108.64891351054;37593;38386;40061;41783.582164179184;37287.25425491529;37761;38105.23789524249;38128.809355953046;38715;33609.663903360655;34612.65387346195;35298;35434;35456.11359716028;26314.736852631228;26409.20772376832;26440.338991525365;26609.068682596015;26838.597421039092 19:04:25 INFO - PROCESS | 1956 | |2;jquery.html;378.85224762342693;382.8755654412317;383.85221689649495;389.1652405590011;389.65710175045956;19592.318227713964;21273.468163295925;21290.254841080565;21510.354689359323;21581.67627485585;20552.691709624367;20989;21206.151753929826;21207.83356915369;22077.779222207773;4408.470983481987;4861.8055277788935;6064.939350606482;6091.177691011723;6098.298695649991;4531;6635.8341041474105;6641.335866413344;6648.93351066488;6653.53425260232;6355.713992870332;6492.727545359134;6570.408663220309;6580.80257592273;6598.307177746339;4386.1447017831215;6594.736210551596;6597;6602.075709400688;6607.041978913078;5448.45515448456;5653.349864765563;5654.151877218409;5665.716714164317;5684.943150568482;25262.873685631454;25315;26716.19851404461;27042.86478567614;27044.59433108505;2224.922127725522;2396.916107936231;2407.4703565215623;2416.891239894209;2843.758280546135;14036.508722194674;14833.925830370887;14959.700805983819;15301.693966120727;15743.921280393639;1706.3771723321022;1811.8912865228128;1820.526663067612;1855.7216417537477;1890.4706682129026;89383.55308223482;99595.53033522515;100183.49908250484;106164;107236.39145412826;8887.688930887389;10575.36547807134;10860.511276992554;11118.110551155889;11154.498047587878;13493.987950903722;13504.797428038391;13513.66215844592;13518.662033449045;13527.256000919848;8790.604422800989;9029.36794424384;9048.185663290336;9134.406263592846;9146;9282.675106371245;9304.25565954722;9312;9399.859002114974;9409.435433873852;6363.649999250086;6446.774362897276;6456.289808121103;6466.482681385478;6469.77355792545;1572.7483602623524;1841.686913224755;1874.09106583307;1879.2764785557658;1905.752252207232;1031.5564307347913;1085.9945700271448;1086.9782604347868;1090.3948308688755;1162.6570161802288;20424.591508169753;21073.367798966057;21183.68224476634;21878.23426180076;21923.561528769336;980.7253968888723;1021.560728886571;1039.750459889621;1048.9370637761758;1066.2642776484201;11280.774384512264;11766.764664706658;11832.349220792767;11901;11904.940475297568;557585;563637;657341;661088;709785;100869;110505.68482945525;122133;130990;131222;1068.615298492542;1078.8759292681284;1107.4905543450104;1110.189561620022;1113.9443027848574;18675.813241867952;18861.434156975312;18992.43022709321;19082;19304.324348648293;42292.36561451519;47299.52700472951;52763.47236527739;53014;53409.198862016325;72113;75764.24235757571;81080.59459702663;83385.58307208425;83817.58091209504;8166.142555031636;8227;8227.053888802864;8312.916870831456;8628.52543110135;13022.088453808521;13500.054996150175;13632.863671363159;13765.518206862711;14050.016498844983;11759.88240117622;11798.292102473879;11871.703207419883;11874.881251187722;12002.279863208236;11464.541418343173;11629.76740465203;11724.41377931083;11944.283342999448;12030.518779248732;11521.423928803359;11896.464659090534;12109.33398663082;12189.08581856382;12217.69455763613;8161.020677518736;8165.061017983008;8302.6678932842;8377.497350158766;8405.07544170153;8649.654013839376;11019.614313498989;11829.84294501814;11975.640730777743;12065.914067733946 19:04:25 INFO - PROCESS | 1956 | |3;mootools.html;1523.185095973653;1648.9010659360438;1684.528332067021;2015.0454059562228;2085.801848824361;8083.51498910065;8908.331875109368;8987.775305617362;8993.910060899381;8996.820063598723;8591.91408085919;8845.380823342368;8853.070427605106;8853.95573022134;8863.379563430562;2252.7521972583086;2520.080170737677;2530.0259400130944;2561.75663311986;2575.742425757428;2578.8065895057853;2584.702759182699;2586.4439145583697;2589.9223023309332;2596.623489594008;2482.478679477303;2572.909948151815;2575.896964121433;2577.265479338389;2589.158523479867;1926.807319268069;2518.937026574341;2561.9487610247784;2566.165996051272;2576.935576610581;2106.5365619563827;2540.0728734011955;2582.2511471673192;2583.4316450380884;2590.106413287413;9065.637374505079;9133.862992055125;9152.084791520861;9174.633014679404;9179.49512776797;5313.840584782462;5483.067878460672;5483.890322193573;5498.1752737089355;5510.8071217507595;3620.1128476556437;3652;3705.2589482103417;3732.216234590739;3742.2328422673286;1043.139409986764;1055.6674647486018;1070.2401295080501;1083.0956151613411;1083.8590983172137;11280.943595282053;11296.661100167008;11313.264637798598;11318.32090074598;11326.773464530663;4102.810185046304;4868.3427737255015;4909.4354149273295;4964.156093464047;4978.253262010728;9833.508324583741;9848.409095454152;9859.161971232383;9868.457234852009;9875.555599998017;5463.836084917459;5475.589330800206;5478.808241711521;5481.958427898766;5487.506124448819;4627.490975992638;4988.052270068675;5087.211482220262;5149.073166829931;5152.433232344439;4085.611866872642;4121.5466298707115;4133.689973252018;4142.440770496005;4150.3566947123245;1337.666712906996;1370.8286464191976;1371.081375478432;1381.5855243427134;1381.6614929342375;1409.2108419285232;1418.652430154598;1434.411891124634;1454.4400405843614;1484.2727063738691;7545;8123.837523249502;8444.028936672361;8553.444026138406;8567.914320856837;526.0609811486478;528.0310629994004;537.1754357061891;539.2719828231934;540.8620801695542;6346.619202847844;6432.51756118293;6495.8700825983215;6514.543981921315;6531.673416329165;10555.947220264003;10913.454327283604;11038.944805275922;11039.889601103887;11049.28179668319;10448.73878153037;10788.244822862323;10817.945910270555;10842.674719758263;10917.945410273056;8505.064442911274;8534.743957681403;8553.016403113721;8599.52702601363;8607.354448416394;7949.682012719427;8006.479578827358;8026.478278911852;8084.434089613671;8091.98850143732;8056.315213206709;9358.391704539183;9606.759831004001;9884.258680599127;9889.50552472388;9827.557759900965;10168.440735759605;10192.796144077225;10196.031377019171;10216.897831021595;6623.801285961429;6822.679127725857;7614.923850761422;7694.769156925301;7780.02749656293;8412.747617571482;8461.323094152576;8475.237228649452;8505.36209784281;8520.3183745299;7382.889256661047;7397.4082073435075;7450.515716478411;7553.584552849646;7634.656440460304;7234.782956511313;7334.853302934018;7367.484276100836;7455.440841936985;7465.664045118091;7752.651130699245;7855.803604909923;7867.370610351272;7867.763967080997;7907.604619768874;7053.470989675692;7090.858182836211;7157.642117894188;7157.749478768218;7166.426685865223;6137.570370074052;7200.8919866201;7266.455015873937;7292.562446253241;7293.562386256842 19:04:25 INFO - PROCESS | 1956 | |4;prototype.html;294.5419872098886;334.8225440516526;336.26190511826553;342.62824835053965;348.1696154671109;6512.869742605145;6615.768448104317;6665.066890635315;6704.731810727577;6737.056812046318;6512.967435162817;6605.405513503783;6607.570507916982;6747;6776.288489708583;4675.345451636774;4756.857294281177;4809.412893745056;4833.782479788418;4911.435184953732;4762.6428017898625;4828.010257897123;4830.299606557047;4843.443004054526;4846.0792449434675;4820.469748327681;4828.637852161084;4839.975800121012;4846.636502262327;4859.392575928009;4608.976955115237;4841.3222148899185;4845.951540484603;4850.345203397532;4855.83004594841;4033.6369726724733;4121.423000779893;4148.813303401324;4149.398337241113;4156.480439945007;5717.685527295997;5832.854178645525;6352.46004089653;6354.142190804228;6370.936290637081;4661.230896902007;5770.422957704238;5775.191473193756;5784.334801497839;5784.68184249866;7032.929670703279;7045.753398631075;7050.6122163281;7051;7058.894116588255;4180.728252663567;4412.007298357876;4423.579759922803;4690.50749671283;4695.413073365829;7305;7438.516496427715;7469.47713660044;7489.4008479322065;7527.397808175388;4704.411948506437;4709.670323077352;4709.8351557696005;4712.52874712526;4714.5521175488275;4385.407969924083;4795.136875362468;4797.544233297831;4812.590929770939;4814.711117332901;5145;5627.606067575312;5650.152477128381;5659.745311460994;5676.0066988276885;5946.583739138306;6868.587884726832;6997.440204783605;7116.039334689751;7124.073870396815;1638.066302207754;1648.8021437427585;1667.8915870468381;1668.9499315020569;1669.499150254943;1044.4203467075695;1055.1137044882337;1066.6959916423782;1075.0646937164718;1077.4989629822014;6288.779892703734;6474.5791523550815;6492.220933488012;6537.411632953057;6551.901721474182;5884.32330282023;6013.849653758603;7065.72816892954;7259.854802903912;7403.51877127985;5612.775488980476;6434.388733070351;6572.34276572339;6581.506387020897;6584.242812076577;3301.4552598821406;3744.045268456526;3852.614738526125;3905.3946638271113;3909.2181563687377;6030.879382412415;7384.113906331275;7595.924040759522;7719.112302085332;7736.2650548197835;7508.474406791582;7523.962380188064;7526.059242594676;7542.811429714301;7652.387808975269;7670.616469176631;7679.6160191990175;7682.1549629540705;7692.19231980634;7713.26723961234;7338.339549440576;7340.26597340283;7342.77971660851;7349;7355.448341374526;7055.329743674342;7166.8924966124505;7262.709491620487;7272.745453909088;7280.269898787955;7583.58290294017;7644.617769111634;7661.540307581563;7665.731699390494;7669.463137580316;4635.490096089495;4692.92960605598;4695.600873925755;4701.294805779024;4703.858884233478;7232.674529646073;7233.927660723325;7239.529430586995;7244.348008679244;7246.782596522113;6780.525363224527;7008.789736307919;7014.158301003912;7037.1555413350725;7082.079329687108;7061.858762824612;7110.57336559808;7111.751088711871;7113.893291600733;7127.786166415016;6500.609963402211;6890.689918953559;6924.688389022607;6925.653717314013;6929.168499779857;7098.183708873339;7112.288771122846;7132.643367831692;7140.964295178491;7142.428605711634;5679.261695979496;6660.034295027097;6682.496438301343;6932.954778340502;6955.339242771928 19:04:25 INFO - PROCESS | 1956 | |5;yui.html;721.7401735375265;769.9153093159755;777.6966982876683;788.4205109244708;804.5172896262243;15025.39898404064;15328.846711532882;15375.769363459543;15382.615434614141;15395.230238488086;14210.07634503759;14271.50049748259;14299.499517516862;14300.785488217685;14309.713805723879;799.9680012799511;815.1155995744624;965.4400447740294;973.3819024919192;1001.2790790630734;834.8914641096649;962.4802606592432;968.5399435268262;983.8622592837008;986.0189111833736;930.8650245714367;1043.9530221140067;1047.6647472808704;1048.072455876551;1049.9972526237464;846.9957650211771;859.1194026123211;1019.2508506247865;1046.2937517175951;1047.1308813684623;780.9336206422461;781.3202513812962;782.5656760497922;785.4227143049853;786.2216405758315;15254.38982440701;15316.463923762614;15323.61690957735;15325.616859578487;15329.846701532953;12773.29746863922;12833.294168820712;12956.287404192766;13015.804762928563;13078.215307081606;10123.696289111265;10449.895501044968;11107.666769996913;11135.498902549323;11308.886911130865;3462.4460086386307;3494.947575786365;3541.9291614167573;3543.291341731638;3598.8740394086344;85510;85546.5722671389;86238;92052.53973730089;92866;9562.091601297865;9647.421154730739;9771.609135634637;9820.803583928424;10460.215483838743;22221.44446388821;22255.3323400295;22272.443188920406;22296.777032229795;22344.99447524865;7387.85224295511;7456.7762967111075;7545.094588649397;7632.351250143689;7708.922910770821;4037.2329257440992;4062.471878655756;4087.7751723654887;4112.013116851994;4146.129312844337;3695.9076023099637;3745.569259535134;3747.5690295616355;3753.4557489163917;3753.7935413551972;652.1684851813975;664.9069130321759;673.0476375928007;679.2358596578849;693.6185098195972;569.237222122358;595.6664268009841;607.3865395950122;607.5230943709167;620.6896551724138;8460;8473.322134229371;8493.872591911126;8521.44610600309;8668.8699669505;618.6133666458463;621.7077973352517;636.0522820996774;647.3979199344654;663.5355251323996;3547.8592990814927;3911.3155197840833;3930.5479869814767;3994.141259629194;4056.019738965078;97322;98103;99902.50048749709;100158;100404.49797750964;81574.59212703898;82052.17947820565;82356;82958.17041829626;83383.5830820842;64038.6798066016;64351.67824160943;65370;65908;66511.66744166249;7849.254320839511;7889.6449659766595;7899.8940148380425;7900.68397264103;7909;50108.24837627366;51296.74351628218;51950.48049519456;52011.73994130005;53278;53008.73495632497;57318.426815731305;59190.70404647949;65413;69689.65155174192;10258.58965641366;10295.07344339013;10415.803839187218;10449.477526123512;10496.790064198825;10932.234743567873;11226.831597525881;11401.201915866142;11530.423478825858;11769.588064417705;11017.338959662446;11213.327200368005;11425.885741142481;11554.76890462203;11621.24461909973;11481.712957176138;11561.28309847202;11567.595134170264;11612.419379031184;11866.703332416413;11143.16426268017;11693.532258709556;11702.70743231426;11753.529858805552;11782.293062416282;9622.9037709622;9847.113759761656;10081.820746731779;10106.039926206999;10150.871249269407;8968.641254350014;9504.47725375111;10004.899951000689;10024;10025.949870250894 19:04:25 INFO - PROCESS | 1956 | __end_tp_report 19:04:25 INFO - PROCESS | 1956 | __start_cc_report 19:04:25 INFO - PROCESS | 1956 | _x_x_mozilla_cycle_collect,1064 19:04:25 INFO - PROCESS | 1956 | __end_cc_report 19:04:25 INFO - PROCESS | 1956 | __startTimestamp1457665465635__endTimestamp 19:04:25 INFO - PROCESS | 1956 | 19:04:25 INFO - PROCESS | 1956 | ------- Summary: start ------- 19:04:25 INFO - PROCESS | 1956 | Number of tests: 6 19:04:25 INFO - PROCESS | 1956 | 19:04:25 INFO - PROCESS | 1956 | [#0] dojo.html Cycles:165 Average:5843.07 Median:6131.36 stddev:643.21 (10.5%) stddev-sans-first:616.51 19:04:25 INFO - PROCESS | 1956 | Values: 3422.2 3518.5 3521.0 3521.7 3568.1 5924.5 5935.6 5946.5 5949.6 5960.7 5902.4 5943.6 5966.1 5968.4 5976.2 5148.2 5216.1 5223.9 5242.5 5290.2 5280.0 5288.2 5290.5 5292.1 5299.4 5219.6 5274.5 5298.9 5302.3 5310.2 5278.9 5327.9 5332.3 5339.0 5341.9 5037.4 5262.6 5263.6 5275.5 5277.1 5618.4 5728.3 5743.9 5757.8 5768.6 6194.5 6279.2 6279.3 6286.7 6298.6 5280.4 6241.4 6274.8 6305.0 6339.8 6006.7 6013.3 6036.1 6041.4 6083.1 6251.5 6347.7 6380.6 6398.9 6400.4 6285.1 6298.2 6307.0 6308.9 6312.0 6301.0 6301.3 6303.8 6316.9 6333.5 6131.9 6184.1 6271.5 6275.6 6300.9 5275.7 6237.6 6262.2 6262.8 6283.3 4973.7 4991.6 4992.5 4996.3 5029.8 4448.2 4456.4 4540.6 4555.5 4562.1 5795.7 5826.6 5840.9 5840.9 5875.7 6314.0 6328.5 6338.5 6343.6 6344.8 5652.3 5807.8 5819.9 5839.7 5872.5 5436.6 5448.8 5464.5 5476.2 5483.7 6440.7 6454.3 6481.5 6509.0 6520.0 6216.8 6282.2 6296.3 6337.2 6381.9 6442.9 6451.6 6465.6 6474.9 6485.5 6172.8 6269.7 6294.6 6294.7 6295.7 6234.5 6276.6 6290.4 6307.9 6311.3 6226.2 6265.1 6265.2 6276.1 6282.0 6102.7 6135.2 6244.5 6256.3 6283.9 5980.7 6107.7 6131.4 6171.6 6172.1 6242.2 6262.3 6282.6 6287.3 6291.7 6015.6 6044.6 6138.1 6150.2 6156.4 19:04:25 INFO - PROCESS | 1956 | 19:04:25 INFO - PROCESS | 1956 | [#1] ext.html Cycles:180 Average:60569.70 Median:206313.94 stddev:119150.59 (57.8%) stddev-sans-first:119399.48 19:04:25 INFO - PROCESS | 1956 | Values: 500.4 595.4 621.4 649.8 661.4 31584.7 32018.0 32063.0 32063.9 32093.5 35134.8 42308.2 42727.0 42749.6 42815.1 9787.8 9978.6 9985.0 9986.0 9997.8 9741.5 9887.9 9890.1 9891.1 9892.6 9849.3 9922.7 9932.0 9935.0 10036.5 9930.6 9993.0 10004.5 10025.9 10032.1 8873.3 9621.6 9849.5 9972.7 9987.9 43067.1 43350.6 43381.8 43409.8 43416.6 3222.6 3341.7 3382.1 3713.9 3927.4 30024.7 30069.1 30079.8 30084.7 30609.8 2788.8 2811.9 2857.9 2878.3 2890.8 374644.0 374667.0 375123.0 375511.0 375522.0 69870.7 70402.0 70418.3 70484.0 70497.6 65818.7 74598.5 78957.8 80229.6 80338.6 15153.5 18396.3 18407.4 18638.3 18650.2 13875.8 13978.6 13988.0 14002.2 14003.0 23028.2 23243.9 23335.6 23337.2 23363.5 9159.3 9375.6 9387.8 9400.5 9410.6 965.7 990.4 1006.0 1084.7 1123.0 27729.7 28119.3 29376.6 30218.7 30740.1 1106.1 1160.1 1161.7 1187.0 1230.9 15465.5 15537.9 15555.6 15614.5 15777.6 554462.0 558983.0 560454.4 561354.4 563714.0 62068.7 63725.4 63802.0 63810.0 63839.0 1366.3 1392.0 1462.8 1487.5 1521.2 29495.9 29866.0 29919.6 30412.9 30640.8 48428.8 48554.5 49026.0 49055.0 49167.5 387612.0 387854.0 388016.0 388266.0 388472.0 30643.7 32194.0 35133.5 35684.9 36152.1 43242.8 43913.1 44302.3 44854.6 45390.9 35503.9 36820.0 36830.8 36923.0 37504.9 35108.6 37593.0 38386.0 40061.0 41783.6 37287.3 37761.0 38105.2 38128.8 38715.0 33609.7 34612.7 35298.0 35434.0 35456.1 26314.7 26409.2 26440.3 26609.1 26838.6 19:04:25 INFO - PROCESS | 1956 | 19:04:25 INFO - PROCESS | 1956 | [#2] jquery.html Cycles:180 Average:35542.27 Median:21546.02 stddev:104698.84 (485.9%) stddev-sans-first:104959.25 19:04:25 INFO - PROCESS | 1956 | Values: 378.9 382.9 383.9 389.2 389.7 19592.3 21273.5 21290.3 21510.4 21581.7 20552.7 20989.0 21206.2 21207.8 22077.8 4408.5 4861.8 6064.9 6091.2 6098.3 4531.0 6635.8 6641.3 6648.9 6653.5 6355.7 6492.7 6570.4 6580.8 6598.3 4386.1 6594.7 6597.0 6602.1 6607.0 5448.5 5653.3 5654.2 5665.7 5684.9 25262.9 25315.0 26716.2 27042.9 27044.6 2224.9 2396.9 2407.5 2416.9 2843.8 14036.5 14833.9 14959.7 15301.7 15743.9 1706.4 1811.9 1820.5 1855.7 1890.5 89383.6 99595.5 100183.5 106164.0 107236.4 8887.7 10575.4 10860.5 11118.1 11154.5 13494.0 13504.8 13513.7 13518.7 13527.3 8790.6 9029.4 9048.2 9134.4 9146.0 9282.7 9304.3 9312.0 9399.9 9409.4 6363.6 6446.8 6456.3 6466.5 6469.8 1572.7 1841.7 1874.1 1879.3 1905.8 1031.6 1086.0 1087.0 1090.4 1162.7 20424.6 21073.4 21183.7 21878.2 21923.6 980.7 1021.6 1039.8 1048.9 1066.3 11280.8 11766.8 11832.3 11901.0 11904.9 557585.0 563637.0 657341.0 661088.0 709785.0 100869.0 110505.7 122133.0 130990.0 131222.0 1068.6 1078.9 1107.5 1110.2 1113.9 18675.8 18861.4 18992.4 19082.0 19304.3 42292.4 47299.5 52763.5 53014.0 53409.2 72113.0 75764.2 81080.6 83385.6 83817.6 8166.1 8227.0 8227.1 8312.9 8628.5 13022.1 13500.1 13632.9 13765.5 14050.0 11759.9 11798.3 11871.7 11874.9 12002.3 11464.5 11629.8 11724.4 11944.3 12030.5 11521.4 11896.5 12109.3 12189.1 12217.7 8161.0 8165.1 8302.7 8377.5 8405.1 8649.7 11019.6 11829.8 11975.6 12065.9 19:04:25 INFO - PROCESS | 1956 | 19:04:25 INFO - PROCESS | 1956 | [#3] mootools.html Cycles:180 Average:6118.96 Median:5469.71 stddev:3195.25 (58.4%) stddev-sans-first:3185.54 19:04:25 INFO - PROCESS | 1956 | Values: 1523.2 1648.9 1684.5 2015.0 2085.8 8083.5 8908.3 8987.8 8993.9 8996.8 8591.9 8845.4 8853.1 8854.0 8863.4 2252.8 2520.1 2530.0 2561.8 2575.7 2578.8 2584.7 2586.4 2589.9 2596.6 2482.5 2572.9 2575.9 2577.3 2589.2 1926.8 2518.9 2561.9 2566.2 2576.9 2106.5 2540.1 2582.3 2583.4 2590.1 9065.6 9133.9 9152.1 9174.6 9179.5 5313.8 5483.1 5483.9 5498.2 5510.8 3620.1 3652.0 3705.3 3732.2 3742.2 1043.1 1055.7 1070.2 1083.1 1083.9 11280.9 11296.7 11313.3 11318.3 11326.8 4102.8 4868.3 4909.4 4964.2 4978.3 9833.5 9848.4 9859.2 9868.5 9875.6 5463.8 5475.6 5478.8 5482.0 5487.5 4627.5 4988.1 5087.2 5149.1 5152.4 4085.6 4121.5 4133.7 4142.4 4150.4 1337.7 1370.8 1371.1 1381.6 1381.7 1409.2 1418.7 1434.4 1454.4 1484.3 7545.0 8123.8 8444.0 8553.4 8567.9 526.1 528.0 537.2 539.3 540.9 6346.6 6432.5 6495.9 6514.5 6531.7 10555.9 10913.5 11038.9 11039.9 11049.3 10448.7 10788.2 10817.9 10842.7 10917.9 8505.1 8534.7 8553.0 8599.5 8607.4 7949.7 8006.5 8026.5 8084.4 8092.0 8056.3 9358.4 9606.8 9884.3 9889.5 9827.6 10168.4 10192.8 10196.0 10216.9 6623.8 6822.7 7614.9 7694.8 7780.0 8412.7 8461.3 8475.2 8505.4 8520.3 7382.9 7397.4 7450.5 7553.6 7634.7 7234.8 7334.9 7367.5 7455.4 7465.7 7752.7 7855.8 7867.4 7867.8 7907.6 7053.5 7090.9 7157.6 7157.7 7166.4 6137.6 7200.9 7266.5 7292.6 7293.6 19:04:25 INFO - PROCESS | 1956 | 19:04:25 INFO - PROCESS | 1956 | [#4] prototype.html Cycles:180 Average:5743.33 Median:6506.74 stddev:1841.38 (28.3%) stddev-sans-first:1800.56 19:04:25 INFO - PROCESS | 1956 | Values: 294.5 334.8 336.3 342.6 348.2 6512.9 6615.8 6665.1 6704.7 6737.1 6513.0 6605.4 6607.6 6747.0 6776.3 4675.3 4756.9 4809.4 4833.8 4911.4 4762.6 4828.0 4830.3 4843.4 4846.1 4820.5 4828.6 4840.0 4846.6 4859.4 4609.0 4841.3 4846.0 4850.3 4855.8 4033.6 4121.4 4148.8 4149.4 4156.5 5717.7 5832.9 6352.5 6354.1 6370.9 4661.2 5770.4 5775.2 5784.3 5784.7 7032.9 7045.8 7050.6 7051.0 7058.9 4180.7 4412.0 4423.6 4690.5 4695.4 7305.0 7438.5 7469.5 7489.4 7527.4 4704.4 4709.7 4709.8 4712.5 4714.6 4385.4 4795.1 4797.5 4812.6 4814.7 5145.0 5627.6 5650.2 5659.7 5676.0 5946.6 6868.6 6997.4 7116.0 7124.1 1638.1 1648.8 1667.9 1668.9 1669.5 1044.4 1055.1 1066.7 1075.1 1077.5 6288.8 6474.6 6492.2 6537.4 6551.9 5884.3 6013.8 7065.7 7259.9 7403.5 5612.8 6434.4 6572.3 6581.5 6584.2 3301.5 3744.0 3852.6 3905.4 3909.2 6030.9 7384.1 7595.9 7719.1 7736.3 7508.5 7524.0 7526.1 7542.8 7652.4 7670.6 7679.6 7682.2 7692.2 7713.3 7338.3 7340.3 7342.8 7349.0 7355.4 7055.3 7166.9 7262.7 7272.7 7280.3 7583.6 7644.6 7661.5 7665.7 7669.5 4635.5 4692.9 4695.6 4701.3 4703.9 7232.7 7233.9 7239.5 7244.3 7246.8 6780.5 7008.8 7014.2 7037.2 7082.1 7061.9 7110.6 7111.8 7113.9 7127.8 6500.6 6890.7 6924.7 6925.7 6929.2 7098.2 7112.3 7132.6 7141.0 7142.4 5679.3 6660.0 6682.5 6933.0 6955.3 19:04:25 INFO - PROCESS | 1956 | 19:04:25 INFO - PROCESS | 1956 | [#5] yui.html Cycles:180 Average:18646.94 Median:4129.07 stddev:26568.94 (643.5%) stddev-sans-first:26609.38 19:04:25 INFO - PROCESS | 1956 | Values: 721.7 769.9 777.7 788.4 804.5 15025.4 15328.8 15375.8 15382.6 15395.2 14210.1 14271.5 14299.5 14300.8 14309.7 800.0 815.1 965.4 973.4 1001.3 834.9 962.5 968.5 983.9 986.0 930.9 1044.0 1047.7 1048.1 1050.0 847.0 859.1 1019.3 1046.3 1047.1 780.9 781.3 782.6 785.4 786.2 15254.4 15316.5 15323.6 15325.6 15329.8 12773.3 12833.3 12956.3 13015.8 13078.2 10123.7 10449.9 11107.7 11135.5 11308.9 3462.4 3494.9 3541.9 3543.3 3598.9 85510.0 85546.6 86238.0 92052.5 92866.0 9562.1 9647.4 9771.6 9820.8 10460.2 22221.4 22255.3 22272.4 22296.8 22345.0 7387.9 7456.8 7545.1 7632.4 7708.9 4037.2 4062.5 4087.8 4112.0 4146.1 3695.9 3745.6 3747.6 3753.5 3753.8 652.2 664.9 673.0 679.2 693.6 569.2 595.7 607.4 607.5 620.7 8460.0 8473.3 8493.9 8521.4 8668.9 618.6 621.7 636.1 647.4 663.5 3547.9 3911.3 3930.5 3994.1 4056.0 97322.0 98103.0 99902.5 100158.0 100404.5 81574.6 82052.2 82356.0 82958.2 83383.6 64038.7 64351.7 65370.0 65908.0 66511.7 7849.3 7889.6 7899.9 7900.7 7909.0 50108.2 51296.7 51950.5 52011.7 53278.0 53008.7 57318.4 59190.7 65413.0 69689.7 10258.6 10295.1 10415.8 10449.5 10496.8 10932.2 11226.8 11401.2 11530.4 11769.6 11017.3 11213.3 11425.9 11554.8 11621.2 11481.7 11561.3 11567.6 11612.4 11866.7 11143.2 11693.5 11702.7 11753.5 11782.3 9622.9 9847.1 10081.8 10106.0 10150.9 8968.6 9504.5 10004.9 10024.0 10025.9 19:04:25 INFO - PROCESS | 1956 | -------- Summary: end -------- 19:04:25 INFO - PROCESS | 1956 | 19:04:26 INFO - TEST-INFO | 1956: exit 0 19:04:26 INFO - TEST-OK | dromaeo_css | took 1112450ms 19:04:26 INFO - TEST-START | kraken 19:04:26 INFO - operating with platform_type : mac_ 19:04:26 INFO - Initialising browser for kraken test... 19:04:26 INFO - TEST-INFO | started process 1961 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/tmp3NBHmu/profile http://localhost:49488/getInfo.html) 19:04:28 INFO - PROCESS | 1961 | __metrics Screen width/height:1600/1200 19:04:28 INFO - PROCESS | 1961 | colorDepth:24 19:04:28 INFO - PROCESS | 1961 | Browser inner width/height: 1024/689 19:04:28 INFO - PROCESS | 1961 | __metrics 19:04:28 INFO - PROCESS | 1961 | 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" 19:04:28 INFO - PROCESS | 1961 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:04:29 INFO - TEST-INFO | 1961: exit 0 19:04:29 INFO - Browser initialized. 19:04:29 INFO - Running cycle 1/1 for kraken test... 19:04:29 INFO - TEST-INFO | started process 1963 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/tmp3NBHmu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:04:41 INFO - PROCESS | 1963 | RSS: Main: 210345984 19:04:41 INFO - PROCESS | 1963 | 19:04:43 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49488/tests/kraken/driver.html?testName=audio-beat-detection) 19:04:44 INFO - PROCESS | 1963 | RSS: Main: 263860224 19:04:44 INFO - PROCESS | 1963 | 19:04:46 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49488/tests/kraken/driver.html?testName=audio-dft) 19:04:47 INFO - PROCESS | 1963 | RSS: Main: 274759680 19:04:47 INFO - PROCESS | 1963 | 19:04:50 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49488/tests/kraken/driver.html?testName=audio-fft) 19:04:51 INFO - PROCESS | 1963 | RSS: Main: 265584640 19:04:51 INFO - PROCESS | 1963 | 19:04:53 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49488/tests/kraken/driver.html?testName=audio-oscillator) 19:04:53 INFO - PROCESS | 1963 | RSS: Main: 267919360 19:04:53 INFO - PROCESS | 1963 | 19:04:55 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49488/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:04:56 INFO - PROCESS | 1963 | RSS: Main: 267268096 19:04:56 INFO - PROCESS | 1963 | 19:04:59 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49488/tests/kraken/driver.html?testName=imaging-darkroom) 19:04:59 INFO - PROCESS | 1963 | RSS: Main: 268910592 19:04:59 INFO - PROCESS | 1963 | 19:05:02 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49488/tests/kraken/driver.html?testName=imaging-desaturate) 19:05:03 INFO - PROCESS | 1963 | RSS: Main: 270196736 19:05:03 INFO - PROCESS | 1963 | 19:05:05 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49488/tests/kraken/driver.html?testName=json-parse-financial) 19:05:06 INFO - PROCESS | 1963 | RSS: Main: 269168640 19:05:06 INFO - PROCESS | 1963 | 19:05:07 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49488/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:05:08 INFO - PROCESS | 1963 | RSS: Main: 300523520 19:05:08 INFO - PROCESS | 1963 | 19:05:10 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:05:11 INFO - PROCESS | 1963 | RSS: Main: 300310528 19:05:11 INFO - PROCESS | 1963 | 19:05:13 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:05:13 INFO - PROCESS | 1963 | RSS: Main: 307154944 19:05:13 INFO - PROCESS | 1963 | 19:05:16 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:05:16 INFO - PROCESS | 1963 | RSS: Main: 310444032 19:05:16 INFO - PROCESS | 1963 | 19:05:19 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:05:19 INFO - PROCESS | 1963 | RSS: Main: 309088256 19:05:19 INFO - PROCESS | 1963 | 19:05:21 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49488/tests/kraken/driver.html?testName=ai-astar) 19:05:21 INFO - PROCESS | 1963 | RSS: Main: 370364416 19:05:21 INFO - PROCESS | 1963 | 19:05:21 INFO - PROCESS | 1963 | __start_tp_report 19:05:21 INFO - PROCESS | 1963 | _x_x_mozilla_page_load 19:05:21 INFO - PROCESS | 1963 | _x_x_mozilla_page_load_details 19:05:21 INFO - PROCESS | 1963 | |i|pagename|runs| 19:05:21 INFO - PROCESS | 1963 | |0;ai-astar;112;109;109;110;111;111;118;112;109;108 19:05:21 INFO - PROCESS | 1963 | |1;audio-beat-detection;153;120;154;149;114;139;115;137;168;151 19:05:21 INFO - PROCESS | 1963 | |2;audio-dft;184;184;186;184;187;188;184;185;182;182 19:05:21 INFO - PROCESS | 1963 | |3;audio-fft;73;75;74;116;58;62;74;80;143;55 19:05:21 INFO - PROCESS | 1963 | |4;audio-oscillator;90;95;131;80;78;84;114;76;78;112 19:05:21 INFO - PROCESS | 1963 | |5;imaging-gaussian-blur;87;86;89;86;91;85;89;85;88;84 19:05:21 INFO - PROCESS | 1963 | |6;imaging-darkroom;93;93;94;95;109;100;144;150;99;103 19:05:21 INFO - PROCESS | 1963 | |7;imaging-desaturate;86;87;87;86;86;85;87;86;86;84 19:05:21 INFO - PROCESS | 1963 | |8;json-parse-financial;55;58;58;59;57;58;58;66;53;51 19:05:21 INFO - PROCESS | 1963 | |9;json-stringify-tinderbox;63;68;73;76;69;67;65;66;67;73 19:05:21 INFO - PROCESS | 1963 | |10;stanford-crypto-aes;81;81;80;78;79;80;80;79;81;84 19:05:21 INFO - PROCESS | 1963 | |11;stanford-crypto-ccm;118;128;121;109;133;124;127;124;116;115 19:05:21 INFO - PROCESS | 1963 | |12;stanford-crypto-pbkdf2;132;122;133;132;131;118;139;131;129;170 19:05:21 INFO - PROCESS | 1963 | |13;stanford-crypto-sha256-iterative;65;65;66;66;65;65;66;66;66;65 19:05:21 INFO - PROCESS | 1963 | __end_tp_report 19:05:21 INFO - PROCESS | 1963 | __start_cc_report 19:05:21 INFO - PROCESS | 1963 | _x_x_mozilla_cycle_collect,1215 19:05:21 INFO - PROCESS | 1963 | __end_cc_report 19:05:21 INFO - PROCESS | 1963 | __startTimestamp1457665521761__endTimestamp 19:05:21 INFO - PROCESS | 1963 | 19:05:21 INFO - PROCESS | 1963 | ------- Summary: start ------- 19:05:21 INFO - PROCESS | 1963 | Number of tests: 14 19:05:21 INFO - PROCESS | 1963 | 19:05:21 INFO - PROCESS | 1963 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:2.85 (2.6%) stddev-sans-first:2.99 19:05:21 INFO - PROCESS | 1963 | Values: 112.0 109.0 109.0 110.0 111.0 111.0 118.0 112.0 109.0 108.0 19:05:21 INFO - PROCESS | 1963 | 19:05:21 INFO - PROCESS | 1963 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:150.00 stddev:18.45 (12.3%) stddev-sans-first:18.95 19:05:21 INFO - PROCESS | 1963 | Values: 153.0 120.0 154.0 149.0 114.0 139.0 115.0 137.0 168.0 151.0 19:05:21 INFO - PROCESS | 1963 | 19:05:21 INFO - PROCESS | 1963 | [#2] audio-dft Cycles:10 Average:184.60 Median:184.50 stddev:1.96 (1.1%) stddev-sans-first:2.06 19:05:21 INFO - PROCESS | 1963 | Values: 184.0 184.0 186.0 184.0 187.0 188.0 184.0 185.0 182.0 182.0 19:05:21 INFO - PROCESS | 1963 | 19:05:21 INFO - PROCESS | 1963 | [#3] audio-fft Cycles:10 Average:81.00 Median:73.50 stddev:27.56 (37.5%) stddev-sans-first:29.08 19:05:21 INFO - PROCESS | 1963 | Values: 73.0 75.0 74.0 116.0 58.0 62.0 74.0 80.0 143.0 55.0 19:05:21 INFO - PROCESS | 1963 | 19:05:21 INFO - PROCESS | 1963 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:79.00 stddev:18.98 (24.0%) stddev-sans-first:20.08 19:05:21 INFO - PROCESS | 1963 | Values: 90.0 95.0 131.0 80.0 78.0 84.0 114.0 76.0 78.0 112.0 19:05:21 INFO - PROCESS | 1963 | 19:05:21 INFO - PROCESS | 1963 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:87.50 stddev:2.21 (2.5%) stddev-sans-first:2.35 19:05:21 INFO - PROCESS | 1963 | Values: 87.0 86.0 89.0 86.0 91.0 85.0 89.0 85.0 88.0 84.0 19:05:21 INFO - PROCESS | 1963 | 19:05:21 INFO - PROCESS | 1963 | [#6] imaging-darkroom Cycles:10 Average:108.00 Median:93.00 stddev:21.20 (22.8%) stddev-sans-first:21.78 19:05:21 INFO - PROCESS | 1963 | Values: 93.0 93.0 94.0 95.0 109.0 100.0 144.0 150.0 99.0 103.0 19:05:21 INFO - PROCESS | 1963 | 19:05:21 INFO - PROCESS | 1963 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.00 stddev:0.94 (1.1%) stddev-sans-first:1.00 19:05:21 INFO - PROCESS | 1963 | Values: 86.0 87.0 87.0 86.0 86.0 85.0 87.0 86.0 86.0 84.0 19:05:21 INFO - PROCESS | 1963 | 19:05:21 INFO - PROCESS | 1963 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:58.00 stddev:4.00 (6.9%) stddev-sans-first:4.16 19:05:21 INFO - PROCESS | 1963 | Values: 55.0 58.0 58.0 59.0 57.0 58.0 58.0 66.0 53.0 51.0 19:05:21 INFO - PROCESS | 1963 | 19:05:21 INFO - PROCESS | 1963 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:68.50 stddev:4.08 (6.0%) stddev-sans-first:3.77 19:05:21 INFO - PROCESS | 1963 | Values: 63.0 68.0 73.0 76.0 69.0 67.0 65.0 66.0 67.0 73.0 19:05:21 INFO - PROCESS | 1963 | 19:05:21 INFO - PROCESS | 1963 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.50 stddev:1.64 (2.0%) stddev-sans-first:1.72 19:05:21 INFO - PROCESS | 1963 | Values: 81.0 81.0 80.0 78.0 79.0 80.0 80.0 79.0 81.0 84.0 19:05:21 INFO - PROCESS | 1963 | 19:05:21 INFO - PROCESS | 1963 | [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:124.00 stddev:7.14 (5.8%) stddev-sans-first:7.46 19:05:21 INFO - PROCESS | 1963 | Values: 118.0 128.0 121.0 109.0 133.0 124.0 127.0 124.0 116.0 115.0 19:05:21 INFO - PROCESS | 1963 | 19:05:21 INFO - PROCESS | 1963 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:133.70 Median:132.00 stddev:14.03 (10.6%) stddev-sans-first:14.87 19:05:21 INFO - PROCESS | 1963 | Values: 132.0 122.0 133.0 132.0 131.0 118.0 139.0 131.0 129.0 170.0 19:05:21 INFO - PROCESS | 1963 | 19:05:21 INFO - PROCESS | 1963 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 19:05:21 INFO - PROCESS | 1963 | Values: 65.0 65.0 66.0 66.0 65.0 65.0 66.0 66.0 66.0 65.0 19:05:21 INFO - PROCESS | 1963 | -------- Summary: end -------- 19:05:21 INFO - PROCESS | 1963 | 19:05:22 INFO - TEST-INFO | 1963: exit 0 19:05:22 INFO - TEST-OK | kraken | took 56295ms 19:05:22 INFO - SUITE-END | took 1168s 19:05:22 INFO - Completed test suite (00:19:29) 19:05:22 INFO - javascript benchmark 19:05:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3422.229998250394, 3518.5425894633695, 3520.964790352096, 3521.6830485256323, 3568.1258091767504, 5924.526037916967, 5935.643861368321, 5946.464818166364, 5949.553783466241, 5960.672163031037, 5902.439268269508, 5943.613665111765, 5966.105084237367, 5968.432998865101, 5976.19321391612, 5148.202028685541, 5216.113260745673, 5223.869403264911, 5242.528172464477, 5290.1800220965615, 5279.996800607892, 5288.180332048539, 5290.497402746752, 5292.073887069767, 5299.364076310848, 5219.582433405338, 5274.498922602365, 5298.867528311785, 5302.257683924254, 5310.230016647583, 5278.868028299285, 5327.920081198785, 5332.253484512191, 5339.038972984861, 5341.919871201935, 5037.420696619899, 5262.552683021948, 5263.552598029172, 5275.472452754732, 5277.102892508283, 5618.381977982419, 5728.283964504437, 5743.913841292384, 5757.798477053283, 5768.6250393724695, 6194.5044396448175, 6279.183706118175, 6279.340669229757, 6286.654234017127, 6298.559100862942, 5280.3663560373, 6241.438270555672, 6274.843128921813, 6305.0, 6339.8415039623915, 6006.669633170174, 6013.308469525973, 6036.094585812163, 6041.426064523863, 6083.057126145454, 6251.531135164881, 6347.682615869188, 6380.617162970237, 6398.9040164397575, 6400.423961843457, 6285.120083188357, 6298.1812364392335, 6306.968465157736, 6308.905366419507, 6311.990081586924, 6301.0, 6301.306856245809, 6303.842403939847, 6316.905246421307, 6333.493320534346, 6131.866048757567, 6184.103305020747, 6271.466925311308, 6275.623462592259, 6300.905486417708, 5275.709835959059, 6237.563370564108, 6262.1859158310035, 6262.812115636538, 6283.3088360280335, 4973.726445045557, 4991.575716064102, 4992.500749924979, 4996.325496057985, 5029.77498900925, 4448.1770872388715, 4456.420665313489, 4540.614047805908, 4555.544445555484, 4562.110388474216, 5795.710214489259, 5826.592138550345, 5840.853978650568, 5840.88318233633, 5875.735591898375, 6313.96843015782, 6328.493720502349, 6338.524610654127, 6343.5876668016435, 6344.809655710336, 5652.349979752299, 5807.796727114615, 5819.912701309484, 5839.708014599338, 5872.530197584183, 5436.6194366393975, 5448.83653490396, 5464.480874316933, 5476.151196564539, 5483.698396588226, 6440.677966101583, 6454.290028096905, 6481.513886458534, 6508.967455162694, 6519.967400162969, 6216.813495595139, 6282.2147231596055, 6296.307406185224, 6337.176167098248, 6381.904271435839, 6442.871142577029, 6451.645159516084, 6465.64438955862, 6474.870502590016, 6485.546011779319, 6172.845678857885, 6269.68651567429, 6294.590851594632, 6294.716737746904, 6295.653739044396, 6234.501239900887, 6276.560640755286, 6290.402411770874, 6307.936920630918, 6311.27420346666, 6226.159468471698, 6265.122882796503, 6265.185525881606, 6276.1213430118905, 6282.0, 6102.7253773579405, 6135.202044401795, 6244.5316601256, 6256.311805701278, 6283.905741413974, 5980.671063091398, 6107.735039974475, 6131.356207598316, 6171.6297022178815, 6172.105044768573, 6242.188515492957, 6262.311145774052, 6282.591631543935, 6287.308396076336, 6291.748330066746, 6015.639061656315, 6044.637321760532, 6138.07928810682, 6150.200473938538, 6156.384361563808], "unit": "score", "name": "dojo.html", "value": 5802.669127607103}, {"lowerIsBetter": false, "replicates": [500.3795293835645, 595.4432605513842, 621.4034526854219, 649.7855707616486, 661.4113439039256, 31584.68415315846, 32018.039458816216, 32063.0, 32063.877764278255, 32093.51859722103, 35134.82432587833, 42308.153836923244, 42727.0, 42749.57250427495, 42815.14369712604, 9787.755306117333, 9978.550965206583, 9984.95007524965, 9986.0, 9997.750056248615, 9741.464219467927, 9887.90112098877, 9890.06044425782, 9891.060349266843, 9892.604295828158, 9849.310548261625, 9922.652707155252, 9931.957144499831, 9934.950325248363, 10036.548355324028, 9930.602775888956, 9993.0, 10004.54979525923, 10025.949870250675, 10032.097111259949, 8873.29013678904, 9621.615135394575, 9849.507524623812, 9972.650957216463, 9987.850182247272, 43067.13865722668, 43350.56649433497, 43381.78309108466, 43409.782951085355, 43416.56583434157, 3222.6455089940087, 3341.6992470677756, 3382.1206486313736, 3713.851445942159, 3927.3912543555793, 30024.69975300241, 30069.097927062223, 30079.849600752073, 30084.69915300841, 30609.846950765328, 2788.762955148815, 2811.9437611247863, 2857.8571071446345, 2878.309205790616, 2890.8174328382147, 374644.0, 374667.0, 375123.0, 375510.99999999726, 375522.0, 69870.65064674644, 70402.0, 70418.29581704117, 70484.0, 70497.64751176212, 65818.67090664516, 74598.50802984019, 78957.81563276556, 80229.59885200537, 80338.59830700808, 15153.54539363821, 18396.26414943414, 18407.355742548945, 18638.254469821328, 18650.16074276661, 13875.791863122062, 13978.580642580739, 13988.0, 14002.22987735664, 14003.0, 23028.19401320979, 23243.883780581327, 23335.649965250534, 23337.18319858797, 23363.53272934532, 9159.336265493856, 9375.578098985561, 9387.765305867271, 9400.529973501298, 9410.623575056921, 965.7151140413595, 990.4354517924713, 1005.9748506287401, 1084.6583326252362, 1122.9949195470008, 27729.730533431764, 28119.32866377691, 29376.559351609314, 30218.697813021587, 30740.077797666105, 1106.1040557148735, 1160.0893298760432, 1161.6689243565543, 1186.9703257418462, 1230.8830661087181, 15465.458708945132, 15537.922310388376, 15555.611109722122, 15614.45349412765, 15777.605559861095, 554462.0, 558983.0, 560454.3954560403, 561354.3864561383, 563714.0, 62068.689656551425, 63725.36274637287, 63802.0, 63810.0, 63839.0, 1366.3100134432048, 1391.9860801392058, 1462.7878957551095, 1487.4570781664615, 1521.1709618258076, 29495.85252073726, 29866.0, 29919.55120673235, 30412.93554725574, 30640.84679576588, 48428.789280268276, 48554.514454855, 49026.0, 49055.0, 49167.50832491629, 387612.0, 387854.0, 388016.0, 388266.0, 388472.0, 30643.693563064084, 32194.0, 35133.47299790556, 35684.92945211648, 36152.096197595274, 43242.783786080865, 43913.121737564434, 44302.33546496741, 44854.55145448504, 45390.865228369556, 35503.93488195358, 36820.0, 36830.8158459206, 36923.0, 37504.87485375443, 35108.64891351054, 37593.0, 38386.0, 40061.0, 41783.582164179184, 37287.25425491529, 37761.0, 38105.23789524249, 38128.809355953046, 38715.0, 33609.663903360655, 34612.65387346195, 35298.0, 35434.0, 35456.11359716028, 26314.736852631228, 26409.20772376832, 26440.338991525365, 26609.068682596015, 26838.597421039092], "unit": "score", "name": "ext.html", "value": 20355.274948436523}, {"lowerIsBetter": false, "replicates": [378.85224762342693, 382.8755654412317, 383.85221689649495, 389.1652405590011, 389.65710175045956, 19592.318227713964, 21273.468163295925, 21290.254841080565, 21510.354689359323, 21581.67627485585, 20552.691709624367, 20989.0, 21206.151753929826, 21207.83356915369, 22077.779222207773, 4408.470983481987, 4861.8055277788935, 6064.939350606482, 6091.177691011723, 6098.298695649991, 4531.0, 6635.8341041474105, 6641.335866413344, 6648.93351066488, 6653.53425260232, 6355.713992870332, 6492.727545359134, 6570.408663220309, 6580.80257592273, 6598.307177746339, 4386.1447017831215, 6594.736210551596, 6597.0, 6602.075709400688, 6607.041978913078, 5448.45515448456, 5653.349864765563, 5654.151877218409, 5665.716714164317, 5684.943150568482, 25262.873685631454, 25315.0, 26716.19851404461, 27042.86478567614, 27044.59433108505, 2224.922127725522, 2396.916107936231, 2407.4703565215623, 2416.891239894209, 2843.758280546135, 14036.508722194674, 14833.925830370887, 14959.700805983819, 15301.693966120727, 15743.921280393639, 1706.3771723321022, 1811.8912865228128, 1820.526663067612, 1855.7216417537477, 1890.4706682129026, 89383.55308223482, 99595.53033522515, 100183.49908250484, 106164.0, 107236.39145412826, 8887.688930887389, 10575.36547807134, 10860.511276992554, 11118.110551155889, 11154.498047587878, 13493.987950903722, 13504.797428038391, 13513.66215844592, 13518.662033449045, 13527.256000919848, 8790.604422800989, 9029.36794424384, 9048.185663290336, 9134.406263592846, 9146.0, 9282.675106371245, 9304.25565954722, 9312.0, 9399.859002114974, 9409.435433873852, 6363.649999250086, 6446.774362897276, 6456.289808121103, 6466.482681385478, 6469.77355792545, 1572.7483602623524, 1841.686913224755, 1874.09106583307, 1879.2764785557658, 1905.752252207232, 1031.5564307347913, 1085.9945700271448, 1086.9782604347868, 1090.3948308688755, 1162.6570161802288, 20424.591508169753, 21073.367798966057, 21183.68224476634, 21878.23426180076, 21923.561528769336, 980.7253968888723, 1021.560728886571, 1039.750459889621, 1048.9370637761758, 1066.2642776484201, 11280.774384512264, 11766.764664706658, 11832.349220792767, 11901.0, 11904.940475297568, 557585.0, 563637.0, 657341.0, 661088.0, 709785.0, 100869.0, 110505.68482945525, 122133.0, 130990.0, 131222.0, 1068.615298492542, 1078.8759292681284, 1107.4905543450104, 1110.189561620022, 1113.9443027848574, 18675.813241867952, 18861.434156975312, 18992.43022709321, 19082.0, 19304.324348648293, 42292.36561451519, 47299.52700472951, 52763.47236527739, 53014.0, 53409.198862016325, 72113.0, 75764.24235757571, 81080.59459702663, 83385.58307208425, 83817.58091209504, 8166.142555031636, 8227.0, 8227.053888802864, 8312.916870831456, 8628.52543110135, 13022.088453808521, 13500.054996150175, 13632.863671363159, 13765.518206862711, 14050.016498844983, 11759.88240117622, 11798.292102473879, 11871.703207419883, 11874.881251187722, 12002.279863208236, 11464.541418343173, 11629.76740465203, 11724.41377931083, 11944.283342999448, 12030.518779248732, 11521.423928803359, 11896.464659090534, 12109.33398663082, 12189.08581856382, 12217.69455763613, 8161.020677518736, 8165.061017983008, 8302.6678932842, 8377.497350158766, 8405.07544170153, 8649.654013839376, 11019.614313498989, 11829.84294501814, 11975.640730777743, 12065.914067733946], "unit": "score", "name": "jquery.html", "value": 9998.667465797791}, {"lowerIsBetter": false, "replicates": [1523.185095973653, 1648.9010659360438, 1684.528332067021, 2015.0454059562228, 2085.801848824361, 8083.51498910065, 8908.331875109368, 8987.775305617362, 8993.910060899381, 8996.820063598723, 8591.91408085919, 8845.380823342368, 8853.070427605106, 8853.95573022134, 8863.379563430562, 2252.7521972583086, 2520.080170737677, 2530.0259400130944, 2561.75663311986, 2575.742425757428, 2578.8065895057853, 2584.702759182699, 2586.4439145583697, 2589.9223023309332, 2596.623489594008, 2482.478679477303, 2572.909948151815, 2575.896964121433, 2577.265479338389, 2589.158523479867, 1926.807319268069, 2518.937026574341, 2561.9487610247784, 2566.165996051272, 2576.935576610581, 2106.5365619563827, 2540.0728734011955, 2582.2511471673192, 2583.4316450380884, 2590.106413287413, 9065.637374505079, 9133.862992055125, 9152.084791520861, 9174.633014679404, 9179.49512776797, 5313.840584782462, 5483.067878460672, 5483.890322193573, 5498.1752737089355, 5510.8071217507595, 3620.1128476556437, 3652.0, 3705.2589482103417, 3732.216234590739, 3742.2328422673286, 1043.139409986764, 1055.6674647486018, 1070.2401295080501, 1083.0956151613411, 1083.8590983172137, 11280.943595282053, 11296.661100167008, 11313.264637798598, 11318.32090074598, 11326.773464530663, 4102.810185046304, 4868.3427737255015, 4909.4354149273295, 4964.156093464047, 4978.253262010728, 9833.508324583741, 9848.409095454152, 9859.161971232383, 9868.457234852009, 9875.555599998017, 5463.836084917459, 5475.589330800206, 5478.808241711521, 5481.958427898766, 5487.506124448819, 4627.490975992638, 4988.052270068675, 5087.211482220262, 5149.073166829931, 5152.433232344439, 4085.611866872642, 4121.5466298707115, 4133.689973252018, 4142.440770496005, 4150.3566947123245, 1337.666712906996, 1370.8286464191976, 1371.081375478432, 1381.5855243427134, 1381.6614929342375, 1409.2108419285232, 1418.652430154598, 1434.411891124634, 1454.4400405843614, 1484.2727063738691, 7545.0, 8123.837523249502, 8444.028936672361, 8553.444026138406, 8567.914320856837, 526.0609811486478, 528.0310629994004, 537.1754357061891, 539.2719828231934, 540.8620801695542, 6346.619202847844, 6432.51756118293, 6495.8700825983215, 6514.543981921315, 6531.673416329165, 10555.947220264003, 10913.454327283604, 11038.944805275922, 11039.889601103887, 11049.28179668319, 10448.73878153037, 10788.244822862323, 10817.945910270555, 10842.674719758263, 10917.945410273056, 8505.064442911274, 8534.743957681403, 8553.016403113721, 8599.52702601363, 8607.354448416394, 7949.682012719427, 8006.479578827358, 8026.478278911852, 8084.434089613671, 8091.98850143732, 8056.315213206709, 9358.391704539183, 9606.759831004001, 9884.258680599127, 9889.50552472388, 9827.557759900965, 10168.440735759605, 10192.796144077225, 10196.031377019171, 10216.897831021595, 6623.801285961429, 6822.679127725857, 7614.923850761422, 7694.769156925301, 7780.02749656293, 8412.747617571482, 8461.323094152576, 8475.237228649452, 8505.36209784281, 8520.3183745299, 7382.889256661047, 7397.4082073435075, 7450.515716478411, 7553.584552849646, 7634.656440460304, 7234.782956511313, 7334.853302934018, 7367.484276100836, 7455.440841936985, 7465.664045118091, 7752.651130699245, 7855.803604909923, 7867.370610351272, 7867.763967080997, 7907.604619768874, 7053.470989675692, 7090.858182836211, 7157.642117894188, 7157.749478768218, 7166.426685865223, 6137.570370074052, 7200.8919866201, 7266.455015873937, 7292.562446253241, 7293.562386256842], "unit": "score", "name": "mootools.html", "value": 4939.921266272024}, {"lowerIsBetter": false, "replicates": [294.5419872098886, 334.8225440516526, 336.26190511826553, 342.62824835053965, 348.1696154671109, 6512.869742605145, 6615.768448104317, 6665.066890635315, 6704.731810727577, 6737.056812046318, 6512.967435162817, 6605.405513503783, 6607.570507916982, 6747.0, 6776.288489708583, 4675.345451636774, 4756.857294281177, 4809.412893745056, 4833.782479788418, 4911.435184953732, 4762.6428017898625, 4828.010257897123, 4830.299606557047, 4843.443004054526, 4846.0792449434675, 4820.469748327681, 4828.637852161084, 4839.975800121012, 4846.636502262327, 4859.392575928009, 4608.976955115237, 4841.3222148899185, 4845.951540484603, 4850.345203397532, 4855.83004594841, 4033.6369726724733, 4121.423000779893, 4148.813303401324, 4149.398337241113, 4156.480439945007, 5717.685527295997, 5832.854178645525, 6352.46004089653, 6354.142190804228, 6370.936290637081, 4661.230896902007, 5770.422957704238, 5775.191473193756, 5784.334801497839, 5784.68184249866, 7032.929670703279, 7045.753398631075, 7050.6122163281, 7051.0, 7058.894116588255, 4180.728252663567, 4412.007298357876, 4423.579759922803, 4690.50749671283, 4695.413073365829, 7305.0, 7438.516496427715, 7469.47713660044, 7489.4008479322065, 7527.397808175388, 4704.411948506437, 4709.670323077352, 4709.8351557696005, 4712.52874712526, 4714.5521175488275, 4385.407969924083, 4795.136875362468, 4797.544233297831, 4812.590929770939, 4814.711117332901, 5145.0, 5627.606067575312, 5650.152477128381, 5659.745311460994, 5676.0066988276885, 5946.583739138306, 6868.587884726832, 6997.440204783605, 7116.039334689751, 7124.073870396815, 1638.066302207754, 1648.8021437427585, 1667.8915870468381, 1668.9499315020569, 1669.499150254943, 1044.4203467075695, 1055.1137044882337, 1066.6959916423782, 1075.0646937164718, 1077.4989629822014, 6288.779892703734, 6474.5791523550815, 6492.220933488012, 6537.411632953057, 6551.901721474182, 5884.32330282023, 6013.849653758603, 7065.72816892954, 7259.854802903912, 7403.51877127985, 5612.775488980476, 6434.388733070351, 6572.34276572339, 6581.506387020897, 6584.242812076577, 3301.4552598821406, 3744.045268456526, 3852.614738526125, 3905.3946638271113, 3909.2181563687377, 6030.879382412415, 7384.113906331275, 7595.924040759522, 7719.112302085332, 7736.2650548197835, 7508.474406791582, 7523.962380188064, 7526.059242594676, 7542.811429714301, 7652.387808975269, 7670.616469176631, 7679.6160191990175, 7682.1549629540705, 7692.19231980634, 7713.26723961234, 7338.339549440576, 7340.26597340283, 7342.77971660851, 7349.0, 7355.448341374526, 7055.329743674342, 7166.8924966124505, 7262.709491620487, 7272.745453909088, 7280.269898787955, 7583.58290294017, 7644.617769111634, 7661.540307581563, 7665.731699390494, 7669.463137580316, 4635.490096089495, 4692.92960605598, 4695.600873925755, 4701.294805779024, 4703.858884233478, 7232.674529646073, 7233.927660723325, 7239.529430586995, 7244.348008679244, 7246.782596522113, 6780.525363224527, 7008.789736307919, 7014.158301003912, 7037.1555413350725, 7082.079329687108, 7061.858762824612, 7110.57336559808, 7111.751088711871, 7113.893291600733, 7127.786166415016, 6500.609963402211, 6890.689918953559, 6924.688389022607, 6925.653717314013, 6929.168499779857, 7098.183708873339, 7112.288771122846, 7132.643367831692, 7140.964295178491, 7142.428605711634, 5679.261695979496, 6660.034295027097, 6682.496438301343, 6932.954778340502, 6955.339242771928], "unit": "score", "name": "prototype.html", "value": 5131.144785633531}, {"lowerIsBetter": false, "replicates": [721.7401735375265, 769.9153093159755, 777.6966982876683, 788.4205109244708, 804.5172896262243, 15025.39898404064, 15328.846711532882, 15375.769363459543, 15382.615434614141, 15395.230238488086, 14210.07634503759, 14271.50049748259, 14299.499517516862, 14300.785488217685, 14309.713805723879, 799.9680012799511, 815.1155995744624, 965.4400447740294, 973.3819024919192, 1001.2790790630734, 834.8914641096649, 962.4802606592432, 968.5399435268262, 983.8622592837008, 986.0189111833736, 930.8650245714367, 1043.9530221140067, 1047.6647472808704, 1048.072455876551, 1049.9972526237464, 846.9957650211771, 859.1194026123211, 1019.2508506247865, 1046.2937517175951, 1047.1308813684623, 780.9336206422461, 781.3202513812962, 782.5656760497922, 785.4227143049853, 786.2216405758315, 15254.38982440701, 15316.463923762614, 15323.61690957735, 15325.616859578487, 15329.846701532953, 12773.29746863922, 12833.294168820712, 12956.287404192766, 13015.804762928563, 13078.215307081606, 10123.696289111265, 10449.895501044968, 11107.666769996913, 11135.498902549323, 11308.886911130865, 3462.4460086386307, 3494.947575786365, 3541.9291614167573, 3543.291341731638, 3598.8740394086344, 85510.0, 85546.5722671389, 86238.0, 92052.53973730089, 92866.0, 9562.091601297865, 9647.421154730739, 9771.609135634637, 9820.803583928424, 10460.215483838743, 22221.44446388821, 22255.3323400295, 22272.443188920406, 22296.777032229795, 22344.99447524865, 7387.85224295511, 7456.7762967111075, 7545.094588649397, 7632.351250143689, 7708.922910770821, 4037.2329257440992, 4062.471878655756, 4087.7751723654887, 4112.013116851994, 4146.129312844337, 3695.9076023099637, 3745.569259535134, 3747.5690295616355, 3753.4557489163917, 3753.7935413551972, 652.1684851813975, 664.9069130321759, 673.0476375928007, 679.2358596578849, 693.6185098195972, 569.237222122358, 595.6664268009841, 607.3865395950122, 607.5230943709167, 620.6896551724138, 8460.0, 8473.322134229371, 8493.872591911126, 8521.44610600309, 8668.8699669505, 618.6133666458463, 621.7077973352517, 636.0522820996774, 647.3979199344654, 663.5355251323996, 3547.8592990814927, 3911.3155197840833, 3930.5479869814767, 3994.141259629194, 4056.019738965078, 97322.0, 98103.0, 99902.50048749709, 100158.0, 100404.49797750964, 81574.59212703898, 82052.17947820565, 82356.0, 82958.17041829626, 83383.5830820842, 64038.6798066016, 64351.67824160943, 65370.0, 65908.0, 66511.66744166249, 7849.254320839511, 7889.6449659766595, 7899.8940148380425, 7900.68397264103, 7909.0, 50108.24837627366, 51296.74351628218, 51950.48049519456, 52011.73994130005, 53278.0, 53008.73495632497, 57318.426815731305, 59190.70404647949, 65413.0, 69689.65155174192, 10258.58965641366, 10295.07344339013, 10415.803839187218, 10449.477526123512, 10496.790064198825, 10932.234743567873, 11226.831597525881, 11401.201915866142, 11530.423478825858, 11769.588064417705, 11017.338959662446, 11213.327200368005, 11425.885741142481, 11554.76890462203, 11621.24461909973, 11481.712957176138, 11561.28309847202, 11567.595134170264, 11612.419379031184, 11866.703332416413, 11143.16426268017, 11693.532258709556, 11702.70743231426, 11753.529858805552, 11782.293062416282, 9622.9037709622, 9847.113759761656, 10081.820746731779, 10106.039926206999, 10150.871249269407, 8968.641254350014, 9504.47725375111, 10004.899951000689, 10024.0, 10025.949870250894], "unit": "score", "name": "yui.html", "value": 7070.901001470055}], "name": "dromaeo_css", "value": 7719.965042808659}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 109.0, 110.0, 111.0, 111.0, 118.0, 112.0, 109.0, 108.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [153.0, 120.0, 154.0, 149.0, 114.0, 139.0, 115.0, 137.0, 168.0, 151.0], "unit": "score", "name": "audio-beat-detection", "value": 140.0}, {"lowerIsBetter": true, "replicates": [184.0, 184.0, 186.0, 184.0, 187.0, 188.0, 184.0, 185.0, 182.0, 182.0], "unit": "score", "name": "audio-dft", "value": 184.6}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 74.0, 116.0, 58.0, 62.0, 74.0, 80.0, 143.0, 55.0], "unit": "score", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [90.0, 95.0, 131.0, 80.0, 78.0, 84.0, 114.0, 76.0, 78.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 93.8}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 89.0, 86.0, 91.0, 85.0, 89.0, 85.0, 88.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.0}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 94.0, 95.0, 109.0, 100.0, 144.0, 150.0, 99.0, 103.0], "unit": "score", "name": "imaging-darkroom", "value": 108.0}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 87.0, 86.0, 86.0, 85.0, 87.0, 86.0, 86.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 86.0}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 58.0, 59.0, 57.0, 58.0, 58.0, 66.0, 53.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [63.0, 68.0, 73.0, 76.0, 69.0, 67.0, 65.0, 66.0, 67.0, 73.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 80.0, 78.0, 79.0, 80.0, 80.0, 79.0, 81.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.3}, {"lowerIsBetter": true, "replicates": [118.0, 128.0, 121.0, 109.0, 133.0, 124.0, 127.0, 124.0, 116.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.5}, {"lowerIsBetter": true, "replicates": [132.0, 122.0, 133.0, 132.0, 131.0, 118.0, 139.0, 131.0, 129.0, 170.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 133.7}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 66.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.5}], "name": "kraken", "value": 1418.3}]} 19:05:22 INFO - Return code: 0 19:05:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:05:23 INFO - # TBPL SUCCESS # 19:05:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:05:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:05:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:05:23 INFO - 2016-03-10 19:05:23.058 screenresolution[1967:12352] starting screenresolution argv=screenresolution get 19:05:23 INFO - 2016-03-10 19:05:23.061 screenresolution[1967:12352] Display 0: 1600x1200x32@60 19:05:23 INFO - 2016-03-10 19:05:23.067 screenresolution[1968:12355] starting screenresolution argv=screenresolution list 19:05:23 INFO - Available Modes on Display 0 19:05:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:05:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:05:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:05:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:05:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:05:23 INFO - Intel Iris: 19:05:23 INFO - Chipset Model: Intel Iris 19:05:23 INFO - Type: GPU 19:05:23 INFO - Bus: Built-In 19:05:23 INFO - VRAM (Dynamic, Max): 1536 MB 19:05:23 INFO - Vendor: Intel (0x8086) 19:05:23 INFO - Device ID: 0x0a2e 19:05:23 INFO - Revision ID: 0x0009 19:05:23 INFO - Displays: 19:05:23 INFO - Display: 19:05:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:05:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:05:23 INFO - Display Serial Number: 1600x1200 60 19:05:23 INFO - Main Display: Yes 19:05:23 INFO - Mirror: Off 19:05:23 INFO - Online: Yes 19:05:23 INFO - Rotation: Supported 19:05:23 INFO - Return code: 0 19:05:23 INFO - Running post-action listener: _resource_record_post_action 19:05:23 INFO - Running post-run listener: _resource_record_post_run 19:05:24 INFO - Total resource usage - Wall time: 1203s; CPU: 52.0%; Read bytes: 704512; Write bytes: 662573568; Read time: 11; Write time: 1927 19:05:24 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 0; Write bytes: 363570688; Read time: 0; Write time: 679 19:05:24 INFO - run-tests - Wall time: 1171s; CPU: 52.0%; Read bytes: 704512; Write bytes: 298155008; Read time: 11; Write time: 1245 19:05:24 INFO - Running post-run listener: _upload_blobber_files 19:05:24 INFO - Blob upload gear active. 19:05:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:05:24 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 19:05:24 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'] 19:05:24 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 19:05:24 INFO - (blobuploader) - INFO - Open directory for files ... 19:05:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:05:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:05:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:05:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:05:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:05:25 INFO - (blobuploader) - INFO - Done attempting. 19:05:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:05:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:05:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:05:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:05:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:05:26 INFO - (blobuploader) - INFO - Done attempting. 19:05:26 INFO - (blobuploader) - INFO - Iteration through files over. 19:05:26 INFO - Return code: 0 19:05:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:05:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:05:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41740ec10c491153663840d281051d275d0742821a4a61d9bffcddc93d2c1a298c71027df0ee96da2588375df179ed1d6aa3efcd8d8e04c2b7d460fc4b1cc4bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2528114a8e12d185acc4d4f81021e08d74642e0da798036339b790f82e332b299ec9caba0c54b3b12b74d56d083c4565459abe9dbdde28217ff0091be3e2ef45"} 19:05:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:05:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:05:26 INFO - Contents: 19:05:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41740ec10c491153663840d281051d275d0742821a4a61d9bffcddc93d2c1a298c71027df0ee96da2588375df179ed1d6aa3efcd8d8e04c2b7d460fc4b1cc4bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2528114a8e12d185acc4d4f81021e08d74642e0da798036339b790f82e332b299ec9caba0c54b3b12b74d56d083c4565459abe9dbdde28217ff0091be3e2ef45"} 19:05:26 INFO - Running post-run listener: copy_logs_to_upload_dir 19:05:26 INFO - Copying logs to upload dir... 19:05:26 INFO - mkdir: /builds/slave/test/build/upload/logs 19:05:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.258413 ========= master_lag: 22.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-03-10 19:05:48.676633) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-03-10 19:05:48.679855) ========= 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.41Aya2muIQ/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.Guccp1gQ2z/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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/41740ec10c491153663840d281051d275d0742821a4a61d9bffcddc93d2c1a298c71027df0ee96da2588375df179ed1d6aa3efcd8d8e04c2b7d460fc4b1cc4bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2528114a8e12d185acc4d4f81021e08d74642e0da798036339b790f82e332b299ec9caba0c54b3b12b74d56d083c4565459abe9dbdde28217ff0091be3e2ef45"} build_url:https://queue.taskcluster.net/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011603 build_url: 'https://queue.taskcluster.net/v1/task/XiMP_99QQ-aqIMGsDbpWDA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41740ec10c491153663840d281051d275d0742821a4a61d9bffcddc93d2c1a298c71027df0ee96da2588375df179ed1d6aa3efcd8d8e04c2b7d460fc4b1cc4bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2528114a8e12d185acc4d4f81021e08d74642e0da798036339b790f82e332b299ec9caba0c54b3b12b74d56d083c4565459abe9dbdde28217ff0091be3e2ef45"}' ========= master_lag: 3.15 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-03-10 19:05:51.845695) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 45 secs) (at 2016-03-10 19:05:51.845986) ========= 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.41Aya2muIQ/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.Guccp1gQ2z/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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.004536 ========= master_lag: 45.94 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 45 secs) (at 2016-03-10 19:06:37.791232) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 19:06:37.791527) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 19:06:38.118344) ========= ========= Total master_lag: 71.30 =========