builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0115 starttime: 1458602420.46 results: success (0) buildid: 20160321141720 builduid: a64a2f12df7f4c74ab094234fbdde118 revision: 5edaa5a69616d6aa6d1cb7f540f1bad734d96977 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 16:20:20.461381) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 16:20:20.461825) ========= ========= Started set props: basedir (results: 0, elapsed: 2 secs) (at 2016-03-21 16:20:20.462111) ========= 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.W0GVmcJMR5/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.jkriioW7M9/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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.005464 basedir: '/builds/slave/test' ========= master_lag: 2.30 ========= ========= Finished set props: basedir (results: 0, elapsed: 2 secs) (at 2016-03-21 16:20:22.771533) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 9 secs) (at 2016-03-21 16:20:22.771850) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 9 secs) (at 2016-03-21 16:20:32.459029) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-03-21 16:20:32.459280) ========= 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.W0GVmcJMR5/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.jkriioW7M9/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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.005887 ========= master_lag: 3.89 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-03-21 16:20:36.357992) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 16:20:36.358278) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 16:20:36.358626) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2016-03-21 16:20:36.358897) ========= 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.W0GVmcJMR5/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.jkriioW7M9/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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-21 16:20:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 44.0M=0s 2016-03-21 16:20:36 (44.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130598 ========= master_lag: 7.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2016-03-21 16:20:43.691332) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 16:20:43.695695) ========= 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.W0GVmcJMR5/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.jkriioW7M9/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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.027192 ========= master_lag: 0.66 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 16:20:44.382953) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2016-03-21 16:20:44.383256) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5edaa5a69616d6aa6d1cb7f540f1bad734d96977 --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 5edaa5a69616d6aa6d1cb7f540f1bad734d96977 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.W0GVmcJMR5/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.jkriioW7M9/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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-21 16:20:44,995 truncating revision to first 12 chars 2016-03-21 16:20:44,995 Setting DEBUG logging. 2016-03-21 16:20:44,995 attempt 1/10 2016-03-21 16:20:44,995 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5edaa5a69616?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-21 16:20:46,042 unpacking tar archive at: mozilla-aurora-5edaa5a69616/testing/mozharness/ program finished with exit code 0 elapsedTime=1.300297 ========= master_lag: 10.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2016-03-21 16:20:55.826096) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-03-21 16:20:55.826810) ========= echo 5edaa5a69616d6aa6d1cb7f540f1bad734d96977 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5edaa5a69616d6aa6d1cb7f540f1bad734d96977'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.W0GVmcJMR5/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.jkriioW7M9/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 5edaa5a69616d6aa6d1cb7f540f1bad734d96977 program finished with exit code 0 elapsedTime=0.005904 script_repo_revision: '5edaa5a69616d6aa6d1cb7f540f1bad734d96977' ========= master_lag: 1.07 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-03-21 16:20:56.900681) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 2 secs) (at 2016-03-21 16:20:56.901041) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 2 secs) (at 2016-03-21 16:20:59.833781) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-21 16:20:59.834049) ========= /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.W0GVmcJMR5/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.jkriioW7M9/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 16:21:01 INFO - MultiFileLogger online at 20160321 16:21:01 in /builds/slave/test 16:21:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:21:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:21:01 INFO - {'append_to_log': False, 16:21:01 INFO - 'base_work_dir': '/builds/slave/test', 16:21:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:21:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:21:01 INFO - 'branch': 'Mozilla-Aurora', 16:21:01 INFO - 'buildbot_json_path': 'buildprops.json', 16:21:01 INFO - 'config_files': ('talos/mac_config.py',), 16:21:01 INFO - 'default_actions': ('clobber', 16:21:01 INFO - 'read-buildbot-config', 16:21:01 INFO - 'download-and-extract', 16:21:01 INFO - 'populate-webroot', 16:21:01 INFO - 'create-virtualenv', 16:21:01 INFO - 'install', 16:21:01 INFO - 'run-tests'), 16:21:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:21:01 INFO - 'download_minidump_stackwalk': True, 16:21:01 INFO - 'download_symbols': 'ondemand', 16:21:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:21:01 INFO - 'tooltool.py': '/tools/tooltool.py', 16:21:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:21:01 INFO - '/tools/misc-python/virtualenv.py')}, 16:21:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:21:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:21:01 INFO - 'installer_path': 'installer.exe', 16:21:01 INFO - 'log_level': 'info', 16:21:01 INFO - 'log_name': 'talos', 16:21:01 INFO - 'log_to_console': True, 16:21:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:21:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:21:01 INFO - 'opt_config_files': (), 16:21:01 INFO - 'pip_index': False, 16:21:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:21:01 INFO - 'cmd': ('bash', 16:21:01 INFO - '-c', 16:21:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:21:01 INFO - 'enabled': True, 16:21:01 INFO - 'halt_on_failure': False, 16:21:01 INFO - 'name': 'check_screen_resolution'},), 16:21:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:21:01 INFO - 'cmd': ('bash', 16:21:01 INFO - '-c', 16:21:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:21:01 INFO - 'enabled': True, 16:21:01 INFO - 'halt_on_failure': False, 16:21:01 INFO - 'name': 'check_screen_resolution'},), 16:21:01 INFO - 'run_cmd_checks_enabled': True, 16:21:01 INFO - 'sps_profile': False, 16:21:01 INFO - 'sps_profile_interval': 0, 16:21:01 INFO - 'suite': 'dromaeojs', 16:21:01 INFO - 'system_bits': '32', 16:21:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:21:01 INFO - 'title': 't-yosemite-r7-0115', 16:21:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:21:01 INFO - 'use_talos_json': True, 16:21:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:21:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:21:01 INFO - 'work_dir': 'build'} 16:21:01 INFO - ##### 16:21:01 INFO - ##### Running clobber step. 16:21:01 INFO - ##### 16:21:01 INFO - Running pre-action listener: _resource_record_pre_action 16:21:01 INFO - Running main action method: clobber 16:21:01 INFO - rmtree: /builds/slave/test/build 16:21:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:21:02 INFO - Running post-action listener: _resource_record_post_action 16:21:02 INFO - ##### 16:21:02 INFO - ##### Running read-buildbot-config step. 16:21:02 INFO - ##### 16:21:02 INFO - Running pre-action listener: _resource_record_pre_action 16:21:02 INFO - Running main action method: read_buildbot_config 16:21:02 INFO - Using buildbot properties: 16:21:02 INFO - { 16:21:02 INFO - "project": "", 16:21:02 INFO - "product": "firefox", 16:21:02 INFO - "script_repo_revision": "production", 16:21:02 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 16:21:02 INFO - "repository": "", 16:21:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 16:21:02 INFO - "buildid": "20160321141720", 16:21:02 INFO - "pgo_build": "False", 16:21:02 INFO - "basedir": "/builds/slave/test", 16:21:02 INFO - "buildnumber": 241, 16:21:02 INFO - "slavename": "t-yosemite-r7-0115", 16:21:02 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:21:02 INFO - "platform": "yosemite_r7", 16:21:02 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:21:02 INFO - "branch": "mozilla-aurora", 16:21:02 INFO - "repo_path": "releases/mozilla-aurora", 16:21:02 INFO - "revision": "5edaa5a69616d6aa6d1cb7f540f1bad734d96977", 16:21:02 INFO - "stage_platform": "macosx64", 16:21:02 INFO - "builduid": "a64a2f12df7f4c74ab094234fbdde118", 16:21:02 INFO - "slavebuilddir": "test" 16:21:02 INFO - } 16:21:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 16:21:02 INFO - Running post-action listener: _resource_record_post_action 16:21:02 INFO - ##### 16:21:02 INFO - ##### Running download-and-extract step. 16:21:02 INFO - ##### 16:21:02 INFO - Running pre-action listener: _resource_record_pre_action 16:21:02 INFO - Running main action method: download_and_extract 16:21:02 INFO - mkdir: /builds/slave/test/build/tests 16:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:02 INFO - https://queue.taskcluster.net/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:21:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 16:21:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 16:21:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 16:21:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 16:21:04 INFO - Downloaded 1277 bytes. 16:21:04 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 16:21:04 INFO - Using the following test package requirements: 16:21:04 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 16:21:04 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:21:04 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 16:21:04 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:21:04 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 16:21:04 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:21:04 INFO - u'jsshell-mac.zip'], 16:21:04 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:21:04 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 16:21:04 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 16:21:04 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:21:04 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 16:21:04 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:21:04 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 16:21:04 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:21:04 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 16:21:04 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 16:21:04 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:21:04 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 16:21:04 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:04 INFO - https://queue.taskcluster.net/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:21:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:21:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:21:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:21:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:21:06 INFO - Downloaded 17869017 bytes. 16:21:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:21:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:21:09 INFO - Return code: 0 16:21:09 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 16:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:09 INFO - https://queue.taskcluster.net/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:21:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:21:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:21:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:21:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:21:10 INFO - Downloaded 17869017 bytes. 16:21:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:21:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:21:14 INFO - Return code: 0 16:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:14 INFO - https://queue.taskcluster.net/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:21:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 16:21:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 16:21:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 16:21:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:21:15 INFO - Downloaded 10845161 bytes. 16:21:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:21:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 16:21:16 INFO - Return code: 0 16:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:16 INFO - https://queue.taskcluster.net/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 16:21:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 16:21:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 16:21:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 16:21:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 16:21:19 INFO - Downloaded 114988162 bytes. 16:21:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 16:21:19 INFO - mkdir: /builds/slave/test/properties 16:21:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:21:19 INFO - Writing to file /builds/slave/test/properties/build_url 16:21:19 INFO - Contents: 16:21:19 INFO - build_url:https://queue.taskcluster.net/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 16:21:20 INFO - Running post-action listener: _resource_record_post_action 16:21:20 INFO - Running post-action listener: set_extra_try_arguments 16:21:20 INFO - ##### 16:21:20 INFO - ##### Running populate-webroot step. 16:21:20 INFO - ##### 16:21:20 INFO - Running pre-action listener: _resource_record_pre_action 16:21:20 INFO - Running main action method: populate_webroot 16:21:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:21:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:21:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:21:20 INFO - '--tppagecycles', 16:21:20 INFO - '7'], 16:21:20 INFO - 'tests': ['tsvgm']}}, 16:21:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:21:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:21:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:21:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:21:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:21:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:21:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:21:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:20 INFO - 'talos_options': ['--e10s'], 16:21:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:21:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:20 INFO - 'tests': ['damp', 'tps']}, 16:21:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:20 INFO - 'talos_options': ['--e10s'], 16:21:20 INFO - 'tests': ['damp', 'tps']}, 16:21:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:21:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:21:20 INFO - 'other': {'tests': ['a11yr', 16:21:20 INFO - 'ts_paint', 16:21:20 INFO - 'tpaint', 16:21:20 INFO - 'sessionrestore', 16:21:20 INFO - 'sessionrestore_no_auto_restore', 16:21:20 INFO - 'tabpaint']}, 16:21:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:21:20 INFO - 'tests': ['a11yr', 16:21:20 INFO - 'ts_paint', 16:21:20 INFO - 'tpaint', 16:21:20 INFO - 'sessionrestore', 16:21:20 INFO - 'sessionrestore_no_auto_restore', 16:21:20 INFO - 'tabpaint']}, 16:21:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:21:20 INFO - 'tests': ['a11yr', 16:21:20 INFO - 'ts_paint', 16:21:20 INFO - 'tpaint', 16:21:20 INFO - 'sessionrestore', 16:21:20 INFO - 'sessionrestore_no_auto_restore', 16:21:20 INFO - 'tabpaint']}, 16:21:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:21:20 INFO - 'tests': ['a11yr', 16:21:20 INFO - 'ts_paint', 16:21:20 INFO - 'tpaint', 16:21:20 INFO - 'sessionrestore', 16:21:20 INFO - 'sessionrestore_no_auto_restore', 16:21:20 INFO - 'tabpaint']}, 16:21:20 INFO - 'other_l64': {'tests': ['a11yr', 16:21:20 INFO - 'ts_paint', 16:21:20 INFO - 'tpaint', 16:21:20 INFO - 'sessionrestore', 16:21:20 INFO - 'sessionrestore_no_auto_restore', 16:21:20 INFO - 'tabpaint']}, 16:21:20 INFO - 'other_nol64': {'tests': ['a11yr', 16:21:20 INFO - 'ts_paint', 16:21:20 INFO - 'tpaint', 16:21:20 INFO - 'sessionrestore', 16:21:20 INFO - 'sessionrestore_no_auto_restore', 16:21:20 INFO - 'tabpaint']}, 16:21:20 INFO - 'svgr': {'tests': ['tsvgx', 16:21:20 INFO - 'tsvgr_opacity', 16:21:20 INFO - 'tart', 16:21:20 INFO - 'tscrollx', 16:21:20 INFO - 'cart']}, 16:21:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:21:20 INFO - 'tests': ['tsvgx', 16:21:20 INFO - 'tsvgr_opacity', 16:21:20 INFO - 'tart', 16:21:20 INFO - 'tscrollx', 16:21:20 INFO - 'cart']}, 16:21:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:20 INFO - 'tests': ['tp5o']}, 16:21:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:20 INFO - 'talos_options': ['--e10s'], 16:21:20 INFO - 'tests': ['tp5o']}, 16:21:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:20 INFO - 'talos_options': ['--xperf_path', 16:21:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:21:20 INFO - 'tests': ['tp5n']}, 16:21:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:20 INFO - 'talos_options': ['--e10s', 16:21:20 INFO - '--xperf_path', 16:21:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:21:20 INFO - 'tests': ['tp5n']}}, 16:21:20 INFO - 'talos.zip': {'path': '', 16:21:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:21:20 INFO - Running post-action listener: _resource_record_post_action 16:21:20 INFO - ##### 16:21:20 INFO - ##### Running create-virtualenv step. 16:21:20 INFO - ##### 16:21:20 INFO - Running pre-action listener: _resource_record_pre_action 16:21:20 INFO - Running main action method: create_virtualenv 16:21:20 INFO - Creating virtualenv /builds/slave/test/build/venv 16:21:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:21:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:21:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:21:20 INFO - Using real prefix '/tools/python27' 16:21:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:21:21 INFO - Installing distribute.............................................................................................................................................................................................done. 16:21:24 INFO - Installing pip.................done. 16:21:24 INFO - Return code: 0 16:21:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:24 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 0x10f8cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8d24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea48dbe520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f76fd30>, '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 0x10f5d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f766b20>, '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.W0GVmcJMR5/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.jkriioW7M9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:21:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:21:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W0GVmcJMR5/Render', 16:21:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:21:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:21:24 INFO - 'HOME': '/Users/cltbld', 16:21:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:21:24 INFO - 'LOGNAME': 'cltbld', 16:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:24 INFO - 'MOZ_NO_REMOTE': '1', 16:21:24 INFO - 'NO_EM_RESTART': '1', 16:21:24 INFO - 'PAGER': '/bin/cat', 16:21:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:24 INFO - 'PWD': '/builds/slave/test', 16:21:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:21:24 INFO - 'SHELL': '/bin/bash', 16:21:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jkriioW7M9/Listeners', 16:21:24 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 16:21:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:21:24 INFO - 'USER': 'cltbld', 16:21:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:21:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:24 INFO - 'XPC_FLAGS': '0x0', 16:21:24 INFO - 'XPC_SERVICE_NAME': '0', 16:21:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:21:24 INFO - Cleaning up... 16:21:24 INFO - Return code: 0 16:21:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:24 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 0x10f8cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8d24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea48dbe520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f76fd30>, '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 0x10f5d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f766b20>, '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.W0GVmcJMR5/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.jkriioW7M9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:21:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:21:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W0GVmcJMR5/Render', 16:21:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:21:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:21:24 INFO - 'HOME': '/Users/cltbld', 16:21:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:21:24 INFO - 'LOGNAME': 'cltbld', 16:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:24 INFO - 'MOZ_NO_REMOTE': '1', 16:21:24 INFO - 'NO_EM_RESTART': '1', 16:21:24 INFO - 'PAGER': '/bin/cat', 16:21:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:24 INFO - 'PWD': '/builds/slave/test', 16:21:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:21:24 INFO - 'SHELL': '/bin/bash', 16:21:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jkriioW7M9/Listeners', 16:21:24 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 16:21:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:21:24 INFO - 'USER': 'cltbld', 16:21:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:21:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:24 INFO - 'XPC_FLAGS': '0x0', 16:21:24 INFO - 'XPC_SERVICE_NAME': '0', 16:21:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:24 INFO - Downloading/unpacking psutil>=0.7.1 16:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:21:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:21:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:21:28 INFO - Installing collected packages: psutil 16:21:28 INFO - Running setup.py install for psutil 16:21:28 INFO - building 'psutil._psutil_osx' extension 16:21:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:21:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:21:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:21:28 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 16:21:29 INFO - building 'psutil._psutil_posix' extension 16:21:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 16:21:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:21:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:21:29 INFO - ^ 16:21:29 INFO - 1 warning generated. 16:21:29 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 16:21:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:21:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:21:29 INFO - Successfully installed psutil 16:21:29 INFO - Cleaning up... 16:21:29 INFO - Return code: 0 16:21:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f8cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8d24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea48dbe520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f76fd30>, '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 0x10f5d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f766b20>, '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.W0GVmcJMR5/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.jkriioW7M9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:21:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:21:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W0GVmcJMR5/Render', 16:21:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:21:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:21:29 INFO - 'HOME': '/Users/cltbld', 16:21:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:21:29 INFO - 'LOGNAME': 'cltbld', 16:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:29 INFO - 'MOZ_NO_REMOTE': '1', 16:21:29 INFO - 'NO_EM_RESTART': '1', 16:21:29 INFO - 'PAGER': '/bin/cat', 16:21:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:29 INFO - 'PWD': '/builds/slave/test', 16:21:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:21:29 INFO - 'SHELL': '/bin/bash', 16:21:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jkriioW7M9/Listeners', 16:21:29 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 16:21:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:21:29 INFO - 'USER': 'cltbld', 16:21:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:21:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:29 INFO - 'XPC_FLAGS': '0x0', 16:21:29 INFO - 'XPC_SERVICE_NAME': '0', 16:21:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:21:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:21:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:21:32 INFO - Installing collected packages: mozsystemmonitor 16:21:32 INFO - Running setup.py install for mozsystemmonitor 16:21:32 INFO - Successfully installed mozsystemmonitor 16:21:32 INFO - Cleaning up... 16:21:32 INFO - Return code: 0 16:21:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:32 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 0x10f8cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8d24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea48dbe520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f76fd30>, '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 0x10f5d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f766b20>, '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.W0GVmcJMR5/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.jkriioW7M9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:21:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:21:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:21:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W0GVmcJMR5/Render', 16:21:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:21:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:21:32 INFO - 'HOME': '/Users/cltbld', 16:21:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:21:32 INFO - 'LOGNAME': 'cltbld', 16:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:32 INFO - 'MOZ_NO_REMOTE': '1', 16:21:32 INFO - 'NO_EM_RESTART': '1', 16:21:32 INFO - 'PAGER': '/bin/cat', 16:21:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:32 INFO - 'PWD': '/builds/slave/test', 16:21:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:21:32 INFO - 'SHELL': '/bin/bash', 16:21:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jkriioW7M9/Listeners', 16:21:32 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 16:21:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:21:32 INFO - 'USER': 'cltbld', 16:21:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:21:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:32 INFO - 'XPC_FLAGS': '0x0', 16:21:32 INFO - 'XPC_SERVICE_NAME': '0', 16:21:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:32 INFO - Downloading/unpacking blobuploader==1.2.4 16:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:35 INFO - Downloading blobuploader-1.2.4.tar.gz 16:21:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:21:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:21:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:36 INFO - Downloading docopt-0.6.1.tar.gz 16:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:21:36 INFO - Installing collected packages: blobuploader, requests, docopt 16:21:36 INFO - Running setup.py install for blobuploader 16:21:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:21:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:21:36 INFO - Running setup.py install for requests 16:21:37 INFO - Running setup.py install for docopt 16:21:37 INFO - Successfully installed blobuploader requests docopt 16:21:37 INFO - Cleaning up... 16:21:37 INFO - Return code: 0 16:21:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:37 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 0x10f8cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8d24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea48dbe520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f76fd30>, '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 0x10f5d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f766b20>, '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.W0GVmcJMR5/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.jkriioW7M9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:21:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:21:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W0GVmcJMR5/Render', 16:21:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:21:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:21:37 INFO - 'HOME': '/Users/cltbld', 16:21:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:21:37 INFO - 'LOGNAME': 'cltbld', 16:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:37 INFO - 'MOZ_NO_REMOTE': '1', 16:21:37 INFO - 'NO_EM_RESTART': '1', 16:21:37 INFO - 'PAGER': '/bin/cat', 16:21:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:37 INFO - 'PWD': '/builds/slave/test', 16:21:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:21:37 INFO - 'SHELL': '/bin/bash', 16:21:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jkriioW7M9/Listeners', 16:21:37 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 16:21:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:21:37 INFO - 'USER': 'cltbld', 16:21:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:21:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:37 INFO - 'XPC_FLAGS': '0x0', 16:21:37 INFO - 'XPC_SERVICE_NAME': '0', 16:21:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:21:37 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-PSoolR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:21:37 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-daDSrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:21:38 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-kx1Og1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:21:38 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-3JCZlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:21:38 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-Zoffab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:21:38 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-cCuwSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:21:38 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-6TxWyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:21:38 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-0MlWQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:21:38 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-xRiFsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:21:38 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-ueMAzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:21:38 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-RItmYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:21:38 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-CbAJCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:21:39 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-LlJVyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:21:39 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-OP2AKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:39 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-qOFJaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:21:39 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-tHpzrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:21:39 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-Fmgmm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:21:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:21:39 INFO - Running setup.py install for manifestparser 16:21:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:21:39 INFO - Running setup.py install for mozcrash 16:21:39 INFO - Running setup.py install for mozdebug 16:21:40 INFO - Running setup.py install for mozdevice 16:21:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:21:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:21:40 INFO - Running setup.py install for mozfile 16:21:40 INFO - Running setup.py install for mozhttpd 16:21:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:21:40 INFO - Running setup.py install for mozinfo 16:21:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:21:40 INFO - Running setup.py install for mozInstall 16:21:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:21:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:21:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:21:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:21:40 INFO - Running setup.py install for mozleak 16:21:40 INFO - Running setup.py install for mozlog 16:21:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:21:41 INFO - Running setup.py install for moznetwork 16:21:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:21:41 INFO - Running setup.py install for mozprocess 16:21:41 INFO - Running setup.py install for mozprofile 16:21:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:21:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:21:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:21:41 INFO - Running setup.py install for mozrunner 16:21:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:21:41 INFO - Running setup.py install for mozscreenshot 16:21:41 INFO - Running setup.py install for moztest 16:21:41 INFO - Running setup.py install for mozversion 16:21:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:21:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:21:42 INFO - Cleaning up... 16:21:42 INFO - Return code: 0 16:21:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:42 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 0x10f8cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8d24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea48dbe520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f76fd30>, '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 0x10f5d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f766b20>, '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.W0GVmcJMR5/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.jkriioW7M9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:21:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:21:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:21:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W0GVmcJMR5/Render', 16:21:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:21:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:21:42 INFO - 'HOME': '/Users/cltbld', 16:21:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:21:42 INFO - 'LOGNAME': 'cltbld', 16:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:42 INFO - 'MOZ_NO_REMOTE': '1', 16:21:42 INFO - 'NO_EM_RESTART': '1', 16:21:42 INFO - 'PAGER': '/bin/cat', 16:21:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:42 INFO - 'PWD': '/builds/slave/test', 16:21:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:21:42 INFO - 'SHELL': '/bin/bash', 16:21:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jkriioW7M9/Listeners', 16:21:42 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 16:21:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:21:42 INFO - 'USER': 'cltbld', 16:21:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:21:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:42 INFO - 'XPC_FLAGS': '0x0', 16:21:42 INFO - 'XPC_SERVICE_NAME': '0', 16:21:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:21:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:21:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-6ztNTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:21:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-Jd36HB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:21:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-Y5grri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:21:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-hRey48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:21:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-_H3y72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:21:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-HljM2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:21:43 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-P5aHVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:21:43 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-Hv61em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:21:43 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-X6C86b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:21:43 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-7na4iD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:21:43 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-hu4YIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:21:43 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-IndgSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:21:43 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-0Hzj8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:21:43 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-UVTkPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:43 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-CZv7Du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:21:44 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-CfQGvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:21:44 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-93ugBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:21:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:46 INFO - Downloading blessings-1.6.tar.gz 16:21:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:21:46 INFO - Installing collected packages: blessings 16:21:46 INFO - Running setup.py install for blessings 16:21:46 INFO - Successfully installed blessings 16:21:46 INFO - Cleaning up... 16:21:47 INFO - Return code: 0 16:21:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:21:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:21:47 INFO - Reading from file tmpfile_stdout 16:21:47 INFO - Current package versions: 16:21:47 INFO - blessings == 1.6 16:21:47 INFO - blobuploader == 1.2.4 16:21:47 INFO - docopt == 0.6.1 16:21:47 INFO - manifestparser == 1.1 16:21:47 INFO - mozInstall == 1.12 16:21:47 INFO - mozcrash == 0.17 16:21:47 INFO - mozdebug == 0.1 16:21:47 INFO - mozdevice == 0.48 16:21:47 INFO - mozfile == 1.2 16:21:47 INFO - mozhttpd == 0.7 16:21:47 INFO - mozinfo == 0.9 16:21:47 INFO - mozleak == 0.1 16:21:47 INFO - mozlog == 3.1 16:21:47 INFO - moznetwork == 0.27 16:21:47 INFO - mozprocess == 0.22 16:21:47 INFO - mozprofile == 0.28 16:21:47 INFO - mozrunner == 6.11 16:21:47 INFO - mozscreenshot == 0.1 16:21:47 INFO - mozsystemmonitor == 0.0 16:21:47 INFO - moztest == 0.7 16:21:47 INFO - mozversion == 1.4 16:21:47 INFO - psutil == 3.1.1 16:21:47 INFO - requests == 1.2.3 16:21:47 INFO - wsgiref == 0.1.2 16:21:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:47 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 0x10f8cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8d24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea48dbe520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f76fd30>, '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 0x10f5d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f766b20>, '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.W0GVmcJMR5/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.jkriioW7M9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:21:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:21:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W0GVmcJMR5/Render', 16:21:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:21:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:21:47 INFO - 'HOME': '/Users/cltbld', 16:21:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:21:47 INFO - 'LOGNAME': 'cltbld', 16:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:47 INFO - 'MOZ_NO_REMOTE': '1', 16:21:47 INFO - 'NO_EM_RESTART': '1', 16:21:47 INFO - 'PAGER': '/bin/cat', 16:21:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:47 INFO - 'PWD': '/builds/slave/test', 16:21:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:21:47 INFO - 'SHELL': '/bin/bash', 16:21:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jkriioW7M9/Listeners', 16:21:47 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 16:21:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:21:47 INFO - 'USER': 'cltbld', 16:21:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:21:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:47 INFO - 'XPC_FLAGS': '0x0', 16:21:47 INFO - 'XPC_SERVICE_NAME': '0', 16:21:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:21:47 INFO - Cleaning up... 16:21:47 INFO - Return code: 0 16:21:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f8cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8d24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea48dbe520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f76fd30>, '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 0x10f5d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f766b20>, '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.W0GVmcJMR5/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.jkriioW7M9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:21:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:21:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W0GVmcJMR5/Render', 16:21:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:21:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:21:47 INFO - 'HOME': '/Users/cltbld', 16:21:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:21:47 INFO - 'LOGNAME': 'cltbld', 16:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:47 INFO - 'MOZ_NO_REMOTE': '1', 16:21:47 INFO - 'NO_EM_RESTART': '1', 16:21:47 INFO - 'PAGER': '/bin/cat', 16:21:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:47 INFO - 'PWD': '/builds/slave/test', 16:21:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:21:47 INFO - 'SHELL': '/bin/bash', 16:21:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jkriioW7M9/Listeners', 16:21:47 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 16:21:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:21:47 INFO - 'USER': 'cltbld', 16:21:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:21:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:47 INFO - 'XPC_FLAGS': '0x0', 16:21:47 INFO - 'XPC_SERVICE_NAME': '0', 16:21:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:47 INFO - Downloading/unpacking jsonschema 16:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:21:50 INFO - Downloading/unpacking functools32 (from jsonschema) 16:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:50 INFO - Downloading functools32-3.2.3-2.tar.gz 16:21:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:21:50 INFO - warning: no files found matching '*.txt' 16:21:50 INFO - no previously-included directories found matching 'build' 16:21:50 INFO - no previously-included directories found matching 'dist' 16:21:50 INFO - no previously-included directories found matching '.git*' 16:21:50 INFO - Installing collected packages: jsonschema, functools32 16:21:50 INFO - Running setup.py install for functools32 16:21:50 INFO - warning: no files found matching '*.txt' 16:21:50 INFO - no previously-included directories found matching 'build' 16:21:50 INFO - no previously-included directories found matching 'dist' 16:21:50 INFO - no previously-included directories found matching '.git*' 16:21:50 INFO - Successfully installed jsonschema functools32 16:21:50 INFO - Cleaning up... 16:21:51 INFO - Return code: 0 16:21:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f8cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8d24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea48dbe520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f76fd30>, '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 0x10f5d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f766b20>, '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.W0GVmcJMR5/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.jkriioW7M9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:21:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:21:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W0GVmcJMR5/Render', 16:21:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:21:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:21:51 INFO - 'HOME': '/Users/cltbld', 16:21:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:21:51 INFO - 'LOGNAME': 'cltbld', 16:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:51 INFO - 'MOZ_NO_REMOTE': '1', 16:21:51 INFO - 'NO_EM_RESTART': '1', 16:21:51 INFO - 'PAGER': '/bin/cat', 16:21:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:51 INFO - 'PWD': '/builds/slave/test', 16:21:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:21:51 INFO - 'SHELL': '/bin/bash', 16:21:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jkriioW7M9/Listeners', 16:21:51 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 16:21:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:21:51 INFO - 'USER': 'cltbld', 16:21:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:21:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:51 INFO - 'XPC_FLAGS': '0x0', 16:21:51 INFO - 'XPC_SERVICE_NAME': '0', 16:21:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:51 INFO - Downloading/unpacking flake8 16:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:21:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:21: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 16:21: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 16:21: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 16:21: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 16:21: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 16:21: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 16:21:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:21:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:21:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:21:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:21:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:21:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:21:54 INFO - no previously-included directories found matching 'docs/_build' 16:21:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:21:55 INFO - Running setup.py install for pep8 16:21:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:21:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:21:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:21:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:21:55 INFO - no previously-included directories found matching 'docs/_build' 16:21:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:21:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:21:55 INFO - Cleaning up... 16:21:55 INFO - Return code: 0 16:21:55 INFO - Running post-action listener: _resource_record_post_action 16:21:55 INFO - Running post-action listener: _start_resource_monitoring 16:21:55 INFO - Starting resource monitoring. 16:21:55 INFO - ##### 16:21:55 INFO - ##### Running install step. 16:21:55 INFO - ##### 16:21:55 INFO - Running pre-action listener: _resource_record_pre_action 16:21:55 INFO - Running main action method: install 16:21:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:21:55 INFO - Reading from file tmpfile_stdout 16:21:55 INFO - Detecting whether we're running mozinstall >=1.0... 16:21:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:21:55 INFO - Reading from file tmpfile_stdout 16:21:55 INFO - Output received: 16:21:55 INFO - Usage: mozinstall [options] installer 16:21:55 INFO - Options: 16:21:55 INFO - -h, --help show this help message and exit 16:21:55 INFO - -d DEST, --destination=DEST 16:21:55 INFO - Directory to install application into. [default: 16:21:55 INFO - "/builds/slave/test"] 16:21:55 INFO - --app=APP Application being installed. [default: firefox] 16:21:55 INFO - mkdir: /builds/slave/test/build/application 16:21:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 16:22:27 INFO - Reading from file tmpfile_stdout 16:22:27 INFO - Output received: 16:22:27 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:22:27 INFO - Running post-action listener: _resource_record_post_action 16:22:27 INFO - ##### 16:22:27 INFO - ##### Running run-tests step. 16:22:27 INFO - ##### 16:22:27 INFO - Running pre-action listener: _resource_record_pre_action 16:22:27 INFO - Running main action method: run_tests 16:22:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:22:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:22:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:22:27 INFO - 2016-03-21 16:22:27.839 screenresolution[1645:7737] starting screenresolution argv=screenresolution get 16:22:27 INFO - 2016-03-21 16:22:27.842 screenresolution[1645:7737] Display 0: 1600x1200x32@60 16:22:27 INFO - 2016-03-21 16:22:27.847 screenresolution[1646:7739] starting screenresolution argv=screenresolution list 16:22:27 INFO - Available Modes on Display 0 16:22:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:22:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:22:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:22:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:22:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:22:28 INFO - Intel Iris: 16:22:28 INFO - Chipset Model: Intel Iris 16:22:28 INFO - Type: GPU 16:22:28 INFO - Bus: Built-In 16:22:28 INFO - VRAM (Dynamic, Max): 1536 MB 16:22:28 INFO - Vendor: Intel (0x8086) 16:22:28 INFO - Device ID: 0x0a2e 16:22:28 INFO - Revision ID: 0x0009 16:22:28 INFO - Displays: 16:22:28 INFO - Display: 16:22:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:22:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:22:28 INFO - Display Serial Number: 1600x1200 60 16:22:28 INFO - Main Display: Yes 16:22:28 INFO - Mirror: Off 16:22:28 INFO - Online: Yes 16:22:28 INFO - Rotation: Supported 16:22:28 INFO - Return code: 0 16:22:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:22:28 INFO - Python 2.7.3 16:22:28 INFO - Return code: 0 16:22:28 INFO - grabbing minidump binary from tooltool 16:22: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')]} 16:22:28 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 0x10f76fd30>, '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 0x10f5d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f766b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:22:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:22:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:22:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:22:28 INFO - Return code: 0 16:22:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:22:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:22:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:22:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:22:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:22:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:22:29 INFO - Return code: 0 16:22:29 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/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0115', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:22:29 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/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0115 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:22:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W0GVmcJMR5/Render', 16:22:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:22:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:22:29 INFO - 'HOME': '/Users/cltbld', 16:22:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:22:29 INFO - 'LOGNAME': 'cltbld', 16:22:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:22:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:29 INFO - 'MOZ_NO_REMOTE': '1', 16:22:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:22:29 INFO - 'NO_EM_RESTART': '1', 16:22:29 INFO - 'PAGER': '/bin/cat', 16:22:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:29 INFO - 'PWD': '/builds/slave/test', 16:22:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:22:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:22:29 INFO - 'SHELL': '/bin/bash', 16:22:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jkriioW7M9/Listeners', 16:22:29 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 16:22:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:22:29 INFO - 'USER': 'cltbld', 16:22:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:22:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:29 INFO - 'XPC_FLAGS': '0x0', 16:22:29 INFO - 'XPC_SERVICE_NAME': '0', 16:22:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:22:29 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/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0115', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:22:29 INFO - mozversion application_buildid: 20160321141720 16:22:29 INFO - mozversion application_changeset: 5edaa5a69616d6aa6d1cb7f540f1bad734d96977 16:22:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:22:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:22:29 INFO - mozversion application_name: Firefox 16:22:29 INFO - mozversion application_remotingname: firefox-dev 16:22:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:22:29 INFO - mozversion application_vendor: Mozilla 16:22:29 INFO - mozversion application_version: 47.0a2 16:22:29 INFO - mozversion platform_buildid: 20160321141720 16:22:29 INFO - mozversion platform_changeset: 5edaa5a69616d6aa6d1cb7f540f1bad734d96977 16:22:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:22:29 INFO - mozversion platform_version: 47.0a2 16:22:29 INFO - using testdate: 1458602549 16:22:29 INFO - actual date: 1458602549 16:22:29 INFO - starting webserver on 'localhost:49270' 16:22:29 INFO - SUITE-START | Running 2 tests 16:22:29 INFO - TEST-START | dromaeo_css 16:22:29 INFO - operating with platform_type : mac_ 16:22:29 INFO - Initialising browser for dromaeo_css test... 16:22:29 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmphuVo5A/profile http://localhost:49270/getInfo.html) 16:22:31 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 16:22:31 INFO - PROCESS | 1664 | colorDepth:24 16:22:31 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 16:22:31 INFO - PROCESS | 1664 | __metrics 16:22:31 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:22:31 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:22:32 INFO - TEST-INFO | 1664: exit 0 16:22:32 INFO - Browser initialized. 16:22:32 INFO - Running cycle 1/1 for dromaeo_css test... 16:22:32 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmphuVo5A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:22:44 INFO - PROCESS | 1667 | RSS: Main: 210698240 16:22:44 INFO - PROCESS | 1667 | 16:23:35 INFO - PROCESS | 1667 | 1458602615587 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:25:45 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 16:25:47 INFO - PROCESS | 1667 | RSS: Main: 350535680 16:25:47 INFO - PROCESS | 1667 | 16:28:49 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 16:28:50 INFO - PROCESS | 1667 | RSS: Main: 347668480 16:28:50 INFO - PROCESS | 1667 | 16:31:52 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 16:31:52 INFO - PROCESS | 1667 | RSS: Main: 351363072 16:31:52 INFO - PROCESS | 1667 | 16:34:54 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 16:34:55 INFO - PROCESS | 1667 | RSS: Main: 307847168 16:34:55 INFO - PROCESS | 1667 | 16:37:58 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 16:37:58 INFO - PROCESS | 1667 | RSS: Main: 311406592 16:37:58 INFO - PROCESS | 1667 | 16:41:01 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 16:41:01 INFO - PROCESS | 1667 | RSS: Main: 373329920 16:41:01 INFO - PROCESS | 1667 | 16:41:01 INFO - PROCESS | 1667 | __start_tp_report 16:41:01 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 16:41:01 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 16:41:01 INFO - PROCESS | 1667 | |i|pagename|runs| 16:41:01 INFO - PROCESS | 1667 | |0;dojo.html;3427.091820667523;3483.947740783887;3492.5808902931644;3534.3991521441353;3557.19963008323;5701.6008879378405;5730.79942202023;5735.885282294362;5742.167385729067;5772.365039845619;5728.198052272674;5779.537636989041;5781.4507621775865;5788.6237394569325;5792.275965504312;5082.898342033157;5155.690658560479;5191.896162076766;5223.033738758342;5322.254884316179;5216.113260745663;5219.321488206528;5223.947760522384;5224.138017227153;5230.450802665722;5174.120399532069;5198.168293073109;5214.165733482643;5217.34783152106;5237.397699264595;5196.506331898482;5239.423663397023;5244.895102097975;5245.4754524547625;5291.735413229323;4502.829264391282;4803.687760295569;5152.639315247934;5169.715665638389;5182;5474.808381706621;5552.694601796899;5564.8330550083565;5594;5594.104943209108;6144.293406258293;6224.813255602339;6237.033259844731;6238.875222495525;6258.718357673915;6181.289151747562;6204.751809927598;6246.469050130744;6255.186825712628;6266.373362663743;5819.82540523785;5827.009408400582;5843.594674925719;5874.647521148745;5880.588358814927;6156.907646385308;6229.252489701174;6249.9062514062325;6261.154744109578;6272.937270627326;6179.16581261524;6181.289151747606;6185.195924529782;6196.690165491707;6203.96898015507;6250.249970003629;6252.124702541648;6253.437190652772;6256.186695729617;6259.71831267594;6016.939830601726;6129.140113879657;6133.737052748297;6226.159468471698;6249.218847644044;6207.5654704171175;6209.9068513972325;6220.533459990519;6240.126382306481;6265.216847894013;4886.53577910098;4898.436679781799;4898.485659005824;4902.828401005948;4942.5304596063315;4417.911641767147;4429.424174857312;4431.534688857688;4476.820927162877;4486.798094085774;4813.831515896997;5702.372738998707;5716.914246286309;5723.055695810228;5740.913886291709;6160.075988601746;6237.064440333896;6243.656598887014;6253.187085678924;6266.937330626726;4757.9286310705365;5681.744321505542;5706.80026199081;5713.657180569096;5730.598858079978;5309.761060752198;5313.654612450256;5373.194020896896;5388.784448622089;5425.26758887553;6276.372362763778;6324.08300796382;6328.208973878265;6344.1118243445035;6347.619142851444;6336.366363363811;6344.143540621957;6357.745690172342;6358.427741503102;6368.554201206057;6246.3753624637175;6277.466415354746;6283.465905397909;6320.957042088188;6346.238451385863;6127.234095738033;6162.506999440124;6170.382961703794;6226.470749986302;6229.408206220402;5345.732713364394;6281.434670879643;6314;6322.589031712924;6326.272478665012;6011.098335249572;6124.173236613178;6140.140380346666;6148.78479253224;6149.2313460817395;6131.254333328352;6187.9480488317995;6189.721462534107;6193.783217587363;6195.752169913153;5142.794288228429;5998.760049597967;6000.219971403864;6022.608530445507;6042.244719410074;5890.705464726832;6043.909341359795;6115.818436018264;6128.662923539248;6199.535034872312;6072.089186622042;6075.908861367171;6088.269407671108;6092.329843717099;6098 16:41:01 INFO - PROCESS | 1667 | |1;ext.html;471.7429001194353;582.1355287398213;599.110321173058;662.1689779326946;669.7488441834312;31181.532277015864;31730;31770.523442148387;31775.205619859516;39052;42377.51678691246;42696.57303426965;42729;42753.93115172122;42898;9587.185089267403;9828.803423931517;9835.557399916985;9839.262055345878;9882.703518894408;9628.566714497865;9764.90235097647;9777.608895644202;9784.315097943147;9786.461744604045;9728.756781080494;9905.108540231378;9907;9917.057879501435;9920.206383489303;9797.412155270707;9864.802703945952;9875.259355548362;9879.06148915859;9881.308308418413;9685.854712179253;9834.655787047419;9839.360441571347;9844.852327215025;9851.507424628811;34152.6584734152;41887.58112418867;42099.1580168398;42335.57664423347;42418.78790606058;3226.6612005739294;3397.3545026445145;3758.5489741230954;3873.0898238913833;3881.378979363288;25500.617490737655;29112.68992895325;29261.97583084603;29404.70595294041;29450;2682.7049024607277;2702.0407755246997;2732.9180124596296;2737.7809775217934;2743.7804975601903;378225;378682;378896;379351;379493;56720.865582688115;66020.33979660238;66946.33053669498;67146;67210.32789672041;69528.3047169532;76159.61920190364;77490.22509774943;77594.22405775983;77632.61183694158;18222.726659100124;18396.080195990147;18476.353327633467;18610.720839187423;18629.161687723812;14080.647983800487;14166.150030997967;14179.007469477245;14195.935304852177;14217.715645687029;21523;21649.458763531038;21732.674009889863;21980.670289945665;22044.33866983993;9740.707778766648;9905.158061564704;10014.54934527948;10020;10055.29612927088;971.9757006074905;1035.30634474902;1044.6604853422668;1064.6805958212506;1119.062723019581;28984.565231521545;30178.69821301803;30438;30504.38991220163;30594.694053059186;1183.662656142995;1197.8323034774965;1251.9061070419573;1294.10706612439;1302.2902518127644;15118.773218401733;15405.614859628598;15442.691146177014;15749.44876929302;15802.60493487649;546122;548618;550260;550320;551525;61438.0784288236;61980.38019619746;62160;62302;62319.6884015577;1422.5945605502588;1549.6590750034975;1551.9301631426613;1568.404006477554;1570.8507691769264;28797;29322.413551729274;29504.967326143484;29614;30145.547816782328;47135.764321178176;47420;47456.525434745214;47482.151070935855;47537.049259015315;313776;322472;322539;322856;324673;29857.95497157676;48834.511654884416;49723.75138124431;50261.99476010386;50892;47581.52418475771;48181.5181848177;49106.50893491019;49390.50609494003;49542;38752.287339887065;39012.80493597514;40680.79659601683;41444;42155;32852.014439566854;38415.6158438412;39313.41029884611;40223.79888100541;40329;39142.608573913894;39351.60648393594;39482.802585988036;40568.78293651077;40612.18775624412;33556.496652549744;35621.82189089038;35783.64216357803;36036;37228.62771372252;26661.333466663487;27043.053493127645;27075;27165.320866978484;27544.862275689295 16:41:01 INFO - PROCESS | 1667 | |2;jquery.html;349.0105550763585;351.9225770330528;383.81576843115306;388.1499516059829;392.1666458775103;20005.099770510325;20532;20743.962801859903;20771.065302061405;21207.893960530175;20706.171753129856;20985.895070524664;21365.572688546257;21368.57262854742;21886.671699924475;5747.655140691561;5981.49157321626;5983.700814959257;5990.49080828128;6013.007853704134;5759.884802303952;5777.797777077803;5959.851003724898;5964.254468191476;5974.103884417329;5863.355030946593;5887;5891.381404952483;5891.823245302648;5895.852603684899;5636.070048442002;5780.335261444925;5821;5826.883462330729;5878.353381128072;5094.79620815167;5111.974440127813;5123.2827404163445;5129.461406552333;5132.84601461953;25829.870850645813;26353.73646263532;26777.866110669518;26783.866080669668;26814;2234.0377999195816;2313.560423519543;2369.869657168855;2487.776100150977;2797.146870204587;15175.62060948474;15302.540923772305;15440.691186176326;15553.844461555353;15602.531924042298;1736.2273788164273;1772.3442326339336;1795.6678014567347;1824.6898027335385;1825.7626508553935;103651;106401;109170.45414772954;109554;109572.35641465384;10993.175511836644;11316.717082073013;11439.142064345207;11540.596079137358;11634.825477617842;13859;13941.930290348484;13987.37056832445;13988.160710357412;14001;9024.774380640405;9186.908130918606;9201.539923003957;9220.677276295432;9312.813743725088;9502.144806967406;9507.429554226768;9537.2370210383;9618.278629102846;9651.227901767841;6594.043863639841;6679.298673639295;6702.128723265944;6704.932950670431;6767.323267673193;1908.0061335904013;1924.5284905198316;1926.2391355414813;1936.3997160880172;1970.4088773367932;425.23245541796734;437.4946936288592;981.6367943860818;1059.1103473082494;1089.128697042363;11622.186446948632;11899.631542372565;11901.88098119025;11978.221415607957;12031.759364812655;456.82412271275797;474.62267497339695;475.40811689446167;490.2181021271067;492.30093267560153;5004.749762511859;6098.35967223444;6191.938080619227;6214.378562143749;6297.559170858088;537687;635191;639651;645941;657018;101050;111297;119202;131621;135090.97363539555;427.8652224549257;469.3499503188109;473.9976300118477;482.129755790794;484.849696594057;11491.367974761468;11594.246373985665;11624.535018599161;11689;11877.58428455;39852;51553.48446515487;51858;52953.47046529486;53538.73230633822;77452;77583.22416775986;77791.2220877784;81087.59456202682;81759.59120204361;8360.623771930155;8362.45644033136;8368.665253389796;8503.574821259035;8696.826063478822;11620.941895290469;13278.136921100098;13575.796363054365;13654.86345136536;13965.301734913011;11405.885941140483;11587.188896777481;11720;11722.472488738198;11819.645410637351;11557.711057223636;11595.304281743123;11635.825462618237;11674.299542027165;11823.704407389883;10751.0324070834;11050;11642.94178529102;11711.531538738354;11828.763424731285;8220.342372610057;8252.546109964009;8266.875996859932;8339.45793523419;8626.439281446686;8744.05153929552;11876.703082423008;11916.463759130687;12050;12109.69725756863 16:41:01 INFO - PROCESS | 1667 | |3;mootools.html;1542.1826431991049;1683.8737094717897;1710.4099085815394;2078.3037682376403;2122.4375540481765;8434.776957341182;8649.308055355572;9084.818303633923;9252.352335336529;9260.58327375268;9108.499032553207;9123.270138388929;9266.768330791734;9268.814623707522;9277.953610231956;2205.9558808823813;2262.8076613487874;2557.283960491061;2584.0955665517013;2589.1196993022368;2340.2511196417154;2512.5854234051358;2566.153169454076;2570.485902819434;2577.6004719268544;2481.1192026830486;2527.5576774064466;2537.9746202538017;2538.4669219463935;2569.845809251451;2509.962350564743;2550.987245063772;2555.2845203343095;2561.871906404691;2564.217913536371;2200.878951657658;2509.1970569417795;2560.948781024369;2563.512932542811;2565.7690807827385;9278;9336.066393360677;9338.206252468548;9347.158755712018;9348.67279645216;5576.637518561281;5742.712864356808;5794.304683437972;5798.797042103548;5813;3626.274745050974;3627.6553727395853;3781.5840257571645;3784.6404591563755;3790.77255364679;1022.9948850255776;1038.8857225705167;1042.5725452564411;1054.9894501054969;1059.6079450603327;12697.873021269761;12703.872961270361;12714.427850746739;12716.618501444971;12723.773339665615;4322.589354011364;5027.673201241908;5112.539871411591;5129.384473863161;5137.768800403991;10603.84094238587;10692.679219623424;10694.251402401756;10696.304740192018;10701.25091243621;5139.254808052886;5505.119180931032;5766.365699773021;5766.567507436959;5773.624714393551;3887.3002859485564;4629.166749984967;5220.791168353223;5221.7128057956415;5231.084560202025;3844.1735026969336;3959.366501359769;4036.3541833307117;4142.542929566926;4197.118605092965;1348.211296391622;1349.5748839115647;1355.8983076269121;1357.5655790147255;1363.1548439967285;1148.5176225985106;1166.4634268236707;1260.9912070343871;1420.5170242117729;1446.4864972934668;8591.398602097917;8652.783680407914;8654.697085601974;8675.089115642893;8681.956590217134;1248.3508575540668;1253.4422182129047;1260.426505939795;1269.6571925580042;1278.5397256987478;6419.454346380517;6444.387783160592;6546.247181574085;6551.246606640298;6568.80293591193;10873.184511161695;11309.604163854226;11350.716232094099;11499.827502587468;11513.942430287794;8780.473171609596;11225.989660930556;11324.433778311051;11405.771884562262;11410.714732131763;8726.86909696355;8750.912490875136;8755.824883502295;8783.780405490043;8871.64513419456;8178.386621003329;8249.587520624065;8298.917010829815;8321.251087402163;8337.541435221121;8281.958590207252;10108.938561450941;10133.240006999356;10144.340617859816;10157.746056348651;10430.947845260725;10613.734656633645;10638.095761860328;10680.679579612624;10802;7602.7339043133225;7807.219278072374;7827.569483678452;7829.177936316605;7842;7814.843703126019;8310.958445207736;8525.062243153372;8527.10465401124;8556.614952327285;7452.590107544137;7592.126905405949;7624.123225829101;7653.961730191313;7700.537967721954;7547.50941188821;7552.244775522404;7585.582792946441;7664.156942736183;7677.155512893689;7915.84168316642;8009.038915330198;8040.718574849852;8044.3162331200165;8155.9184408157535;7235.131784185932;7274.745383911538;7349.963250183715;7354.8896766549615;7358.484906056525;7435.553866768011;7524.849503009799;7526.360259378014;7530.623468826428;7540.622968851645 16:41:01 INFO - PROCESS | 1667 | |4;prototype.html;336.68351749355605;340.8636545381847;345.4973014264246;348.0741228332636;350.2102758280078;6597.769078082268;6608.107905432771;6620.9006864897;6649.401553860152;6697.0289308050305;6533.803985880431;6535;6544.247411547662;6550.5742126761725;6560.967195164029;4657.161710892038;4727.1254817858635;4759.7144171349655;4861.513848615145;4902.240152776325;4833.661643684944;4849.369581954358;4849.878753031167;4864.708117512942;4897.559219670229;4809.038192361541;4817.566419022287;4819.855404337858;4825.469198388175;4829.623557286174;4559.475660299075;4659.1147681940665;4667.766611669437;4669.859904202863;4794.544518270759;3523.4010218262956;3604.42329227325;3860.305145073886;3976.846714452834;4157.417961485395;6152.200748659349;6222.595531290452;6230.937690623081;6271.968640156816;6282.780102696383;5766.826995190151;5768.163616275617;5771.192033115367;5771.682557459338;5788.797392091256;6981.581105133709;6984.965075174642;6989.965050174767;6999.440044796404;6999.930000699978;3925.60743925608;4359.149965756678;4593.425821772278;4599.770011499445;4610.792514336863;7247.094113235846;7364.116306043309;7370.041894553728;7395.2235015323695;7401.185869554345;4663.953360466352;4669.229577119805;4678.812847486062;4681.391419115494;4695.483496815347;3897.61023897608;4739.644526660514;4744.501827308152;4745;4745.596624286905;5607.299087614048;5610.663360198401;5613;5618.269624948731;5618.606697531133;6704;6947.51367404287;6959.652017399211;6967.686454109577;7043.119610048744;1624.4395683489176;1627.7802496663037;1640.9425670101489;1642.24456749894;1645;1012.2711647613706;1030.3096925060227;1046.1160319529986;1055.6621880998007;1060.5439660945713;6349.492040636738;6472.870542589122;6624.701888415033;6631.237407698177;6643.966780166165;7348.669309881068;7359.264073592598;7364.2635736427;7367.77896663101;7378.077740282465;6583.868322633521;6625.933740662628;6626.237982632059;6635.2037755469655;6636.402723754885;3199.504076868089;3786.8674596388996;3878.903027424337;3881.6700580450415;3881.8059097045034;7341.3392794648735;7614.048243969504;7622.542647441061;7625.961870190614;7629.8855517167285;6116.480099191618;7498.212687667826;7546.5094768840945;7549.282818132378;7570.318671319607;7021.630781997462;7571.583562904093;7585.58279294633;7591.278828511283;7600.543967361976;5925.9407405925385;6516.902246466401;7063.081799366049;7338.486305958745;7340.15588207363;7190.96404517974;7197.676104575202;7200.531965422231;7201.747938822116;7210.74762383335;7523.774286771406;7563.621818908922;7574.545527268381;7579.1284002340435;7579.431542634215;4681.953180468152;4684.789184486638;4690.507496712932;4691.671582989295;4695.084458530554;7035.648217589202;7264.600446975256;7271.672774725044;7275.272472752894;7277.345038946521;7041.612711300722;7055.4708396871465;7059.788206353817;7074.327938845801;7083.716651333889;6996.370326670624;7041.401480874183;7047.964760176166;7054;7070.1869285030825;6886.8622627548175;6889.483288753263;6892.207396149507;6893.172819261721;6894.551854129466;5031.471695471922;6753.729850805913;7036.2260151384335;7053.400460960671;7054.153501579844;6673.165854268216;6713.798586042427;6911.896321555281;6912;6933.128055425108 16:41:01 INFO - PROCESS | 1667 | |5;yui.html;724.4675163754639;728.3044692318836;754.8075240813594;764.3923081150485;780.5823884221942;12091.274523528573;14827.703445931089;14941;15038.323275452603;15071.321790519425;13396.799048014287;14476.5657030289;14481.058731182493;14483.782743258833;14492.855071449283;792.3502727763237;801.9238172373645;951.3720944176845;962.7448726087592;982.2485798364221;953.5708930981051;958.2860768727273;959.1080295325345;959.8800149981253;1000.334777373046;1008.8738907636546;1009.5204777730593;1010.0051449322448;1011.1708399112731;1045.3884477580625;813.8494378539959;816.8938038055074;828.2214718164936;1018.3991445047458;1037.2790910317333;766.5247546521136;774.8295375017543;775.5850619918317;777.0519965641907;777.4169372970272;15115.848841511553;15215.923920380328;15216.619584510365;15223.162726050063;15246.618834529114;12381.876181238162;12430.378481076;12508.624741257685;12689.746205075939;12713.364331783374;10146.235961744522;10157.441340726256;10239.283250172492;10251.589936402535;10484.633037843716;3497.24809166028;3557.4130268505924;3557.7865328080397;3613.927721445583;3615.6745892869767;80424.19575804226;82038.58980705118;82154.58922705348;82296.58851705764;82650.58674706648;9312.441253524674;9598.32811703188;9690.079442452956;9746.707598772047;9943.651972180938;22093.779062209494;22422.87885605713;22430.439239019153;22436.10255589791;22466.10135594558;7632.188009535319;7688.961555192188;7803.375729941591;7977.3219276361;7983.640736166886;4208.537060923296;4295.4201182839915;4302.548232435612;4304.160688665743;4493.573110554492;3718.3678774608384;3764.1342491226624;3766.472693822867;3768.811559422018;3769.981150094287;662.6421732264523;673.9452756436161;677.1873751498222;687.8039758668756;689.565573688573;527.9208118782213;600.2197143713155;601.3295175878864;624.6002558362652;633.2021652717609;8287.751367458986;8465.619047142893;8490.27832634233;8528.714567438861;8621.684541456916;524.2477045439806;561.6349372907642;595.9553033522417;607.1499900139752;624.6127401011402;3869.5163104611925;3933.1936952925153;3976.687693061283;3988.920221595552;4011.8997025074605;94612;95416;95452.52273738726;95773.52113239389;96007.0399296012;82318.58840705758;82612;82982.58508707419;83007;84137;72512.63743681248;72818;73054.99999999894;73057.53884922378;74923.62538187383;7741.264579864904;7854.803629909298;8065.274125328749;8065.475744076616;8095.069067057364;51835;52815.73592132015;52869.7356513215;53284;54162;59730.104048438436;69110.3088969124;69414.65292673504;73563.63218183875;74448;10325.845112323172;10355.326903751233;11122.99893009633;11467.541298347973;11748.588799392322;11817.822732658846;11923.940380298043;11979.940100299442;11990.448236406288;12820.102592818414;11315.660530184108;11628;11730.413479326171;11791.35147566892;11925.880741192825;11279.342839306744;11645.717510655924;11889.929906308475;11942.582009629621;12065.336406497727;11124.944375278072;11478.368689722145;11573.537058517564;11758.70603234926;11782.941085294518;9640.132388084825;9652.806943860944;9751.51242437861;10033.498325083863;10191.796164076824;9264.44413335202;9800.166985806287;9829.361091529314;9870.555824987749;9895.604175832887 16:41:01 INFO - PROCESS | 1667 | __end_tp_report 16:41:01 INFO - PROCESS | 1667 | __start_cc_report 16:41:01 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1259 16:41:01 INFO - PROCESS | 1667 | __end_cc_report 16:41:01 INFO - PROCESS | 1667 | __startTimestamp1458603661612__endTimestamp 16:41:01 INFO - PROCESS | 1667 | 16:41:01 INFO - PROCESS | 1667 | ------- Summary: start ------- 16:41:01 INFO - PROCESS | 1667 | Number of tests: 6 16:41:01 INFO - PROCESS | 1667 | 16:41:01 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5737.33 Median:6022.61 stddev:648.74 (10.8%) stddev-sans-first:624.90 16:41:01 INFO - PROCESS | 1667 | Values: 3427.1 3483.9 3492.6 3534.4 3557.2 5701.6 5730.8 5735.9 5742.2 5772.4 5728.2 5779.5 5781.5 5788.6 5792.3 5082.9 5155.7 5191.9 5223.0 5322.3 5216.1 5219.3 5223.9 5224.1 5230.5 5174.1 5198.2 5214.2 5217.3 5237.4 5196.5 5239.4 5244.9 5245.5 5291.7 4502.8 4803.7 5152.6 5169.7 5182.0 5474.8 5552.7 5564.8 5594.0 5594.1 6144.3 6224.8 6237.0 6238.9 6258.7 6181.3 6204.8 6246.5 6255.2 6266.4 5819.8 5827.0 5843.6 5874.6 5880.6 6156.9 6229.3 6249.9 6261.2 6272.9 6179.2 6181.3 6185.2 6196.7 6204.0 6250.2 6252.1 6253.4 6256.2 6259.7 6016.9 6129.1 6133.7 6226.2 6249.2 6207.6 6209.9 6220.5 6240.1 6265.2 4886.5 4898.4 4898.5 4902.8 4942.5 4417.9 4429.4 4431.5 4476.8 4486.8 4813.8 5702.4 5716.9 5723.1 5740.9 6160.1 6237.1 6243.7 6253.2 6266.9 4757.9 5681.7 5706.8 5713.7 5730.6 5309.8 5313.7 5373.2 5388.8 5425.3 6276.4 6324.1 6328.2 6344.1 6347.6 6336.4 6344.1 6357.7 6358.4 6368.6 6246.4 6277.5 6283.5 6321.0 6346.2 6127.2 6162.5 6170.4 6226.5 6229.4 5345.7 6281.4 6314.0 6322.6 6326.3 6011.1 6124.2 6140.1 6148.8 6149.2 6131.3 6187.9 6189.7 6193.8 6195.8 5142.8 5998.8 6000.2 6022.6 6042.2 5890.7 6043.9 6115.8 6128.7 6199.5 6072.1 6075.9 6088.3 6092.3 6098.0 16:41:01 INFO - PROCESS | 1667 | 16:41:01 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:58879.13 Median:21447.09 stddev:113373.96 (528.6%) stddev-sans-first:113607.19 16:41:01 INFO - PROCESS | 1667 | Values: 471.7 582.1 599.1 662.2 669.7 31181.5 31730.0 31770.5 31775.2 39052.0 42377.5 42696.6 42729.0 42753.9 42898.0 9587.2 9828.8 9835.6 9839.3 9882.7 9628.6 9764.9 9777.6 9784.3 9786.5 9728.8 9905.1 9907.0 9917.1 9920.2 9797.4 9864.8 9875.3 9879.1 9881.3 9685.9 9834.7 9839.4 9844.9 9851.5 34152.7 41887.6 42099.2 42335.6 42418.8 3226.7 3397.4 3758.5 3873.1 3881.4 25500.6 29112.7 29262.0 29404.7 29450.0 2682.7 2702.0 2732.9 2737.8 2743.8 378225.0 378682.0 378896.0 379351.0 379493.0 56720.9 66020.3 66946.3 67146.0 67210.3 69528.3 76159.6 77490.2 77594.2 77632.6 18222.7 18396.1 18476.4 18610.7 18629.2 14080.6 14166.2 14179.0 14195.9 14217.7 21523.0 21649.5 21732.7 21980.7 22044.3 9740.7 9905.2 10014.5 10020.0 10055.3 972.0 1035.3 1044.7 1064.7 1119.1 28984.6 30178.7 30438.0 30504.4 30594.7 1183.7 1197.8 1251.9 1294.1 1302.3 15118.8 15405.6 15442.7 15749.4 15802.6 546122.0 548618.0 550260.0 550320.0 551525.0 61438.1 61980.4 62160.0 62302.0 62319.7 1422.6 1549.7 1551.9 1568.4 1570.9 28797.0 29322.4 29505.0 29614.0 30145.5 47135.8 47420.0 47456.5 47482.2 47537.0 313776.0 322472.0 322539.0 322856.0 324673.0 29858.0 48834.5 49723.8 50262.0 50892.0 47581.5 48181.5 49106.5 49390.5 49542.0 38752.3 39012.8 40680.8 41444.0 42155.0 32852.0 38415.6 39313.4 40223.8 40329.0 39142.6 39351.6 39482.8 40568.8 40612.2 33556.5 35621.8 35783.6 36036.0 37228.6 26661.3 27043.1 27075.0 27165.3 27544.9 16:41:01 INFO - PROCESS | 1667 | 16:41:01 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:34905.58 Median:1573.08 stddev:103679.78 (6590.9%) stddev-sans-first:103938.16 16:41:01 INFO - PROCESS | 1667 | Values: 349.0 351.9 383.8 388.1 392.2 20005.1 20532.0 20744.0 20771.1 21207.9 20706.2 20985.9 21365.6 21368.6 21886.7 5747.7 5981.5 5983.7 5990.5 6013.0 5759.9 5777.8 5959.9 5964.3 5974.1 5863.4 5887.0 5891.4 5891.8 5895.9 5636.1 5780.3 5821.0 5826.9 5878.4 5094.8 5112.0 5123.3 5129.5 5132.8 25829.9 26353.7 26777.9 26783.9 26814.0 2234.0 2313.6 2369.9 2487.8 2797.1 15175.6 15302.5 15440.7 15553.8 15602.5 1736.2 1772.3 1795.7 1824.7 1825.8 103651.0 106401.0 109170.5 109554.0 109572.4 10993.2 11316.7 11439.1 11540.6 11634.8 13859.0 13941.9 13987.4 13988.2 14001.0 9024.8 9186.9 9201.5 9220.7 9312.8 9502.1 9507.4 9537.2 9618.3 9651.2 6594.0 6679.3 6702.1 6704.9 6767.3 1908.0 1924.5 1926.2 1936.4 1970.4 425.2 437.5 981.6 1059.1 1089.1 11622.2 11899.6 11901.9 11978.2 12031.8 456.8 474.6 475.4 490.2 492.3 5004.7 6098.4 6191.9 6214.4 6297.6 537687.0 635191.0 639651.0 645941.0 657018.0 101050.0 111297.0 119202.0 131621.0 135091.0 427.9 469.3 474.0 482.1 484.8 11491.4 11594.2 11624.5 11689.0 11877.6 39852.0 51553.5 51858.0 52953.5 53538.7 77452.0 77583.2 77791.2 81087.6 81759.6 8360.6 8362.5 8368.7 8503.6 8696.8 11620.9 13278.1 13575.8 13654.9 13965.3 11405.9 11587.2 11720.0 11722.5 11819.6 11557.7 11595.3 11635.8 11674.3 11823.7 10751.0 11050.0 11642.9 11711.5 11828.8 8220.3 8252.5 8266.9 8339.5 8626.4 8744.1 11876.7 11916.5 12050.0 12109.7 16:41:01 INFO - PROCESS | 1667 | 16:41:01 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:6332.74 Median:4828.42 stddev:3367.10 (69.7%) stddev-sans-first:3357.30 16:41:01 INFO - PROCESS | 1667 | Values: 1542.2 1683.9 1710.4 2078.3 2122.4 8434.8 8649.3 9084.8 9252.4 9260.6 9108.5 9123.3 9266.8 9268.8 9278.0 2206.0 2262.8 2557.3 2584.1 2589.1 2340.3 2512.6 2566.2 2570.5 2577.6 2481.1 2527.6 2538.0 2538.5 2569.8 2510.0 2551.0 2555.3 2561.9 2564.2 2200.9 2509.2 2560.9 2563.5 2565.8 9278.0 9336.1 9338.2 9347.2 9348.7 5576.6 5742.7 5794.3 5798.8 5813.0 3626.3 3627.7 3781.6 3784.6 3790.8 1023.0 1038.9 1042.6 1055.0 1059.6 12697.9 12703.9 12714.4 12716.6 12723.8 4322.6 5027.7 5112.5 5129.4 5137.8 10603.8 10692.7 10694.3 10696.3 10701.3 5139.3 5505.1 5766.4 5766.6 5773.6 3887.3 4629.2 5220.8 5221.7 5231.1 3844.2 3959.4 4036.4 4142.5 4197.1 1348.2 1349.6 1355.9 1357.6 1363.2 1148.5 1166.5 1261.0 1420.5 1446.5 8591.4 8652.8 8654.7 8675.1 8682.0 1248.4 1253.4 1260.4 1269.7 1278.5 6419.5 6444.4 6546.2 6551.2 6568.8 10873.2 11309.6 11350.7 11499.8 11513.9 8780.5 11226.0 11324.4 11405.8 11410.7 8726.9 8750.9 8755.8 8783.8 8871.6 8178.4 8249.6 8298.9 8321.3 8337.5 8282.0 10108.9 10133.2 10144.3 10157.7 10430.9 10613.7 10638.1 10680.7 10802.0 7602.7 7807.2 7827.6 7829.2 7842.0 7814.8 8311.0 8525.1 8527.1 8556.6 7452.6 7592.1 7624.1 7654.0 7700.5 7547.5 7552.2 7585.6 7664.2 7677.2 7915.8 8009.0 8040.7 8044.3 8155.9 7235.1 7274.7 7350.0 7354.9 7358.5 7435.6 7524.8 7526.4 7530.6 7540.6 16:41:01 INFO - PROCESS | 1667 | 16:41:01 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:5727.63 Median:6572.42 stddev:1846.00 (28.1%) stddev-sans-first:1806.29 16:41:01 INFO - PROCESS | 1667 | Values: 336.7 340.9 345.5 348.1 350.2 6597.8 6608.1 6620.9 6649.4 6697.0 6533.8 6535.0 6544.2 6550.6 6561.0 4657.2 4727.1 4759.7 4861.5 4902.2 4833.7 4849.4 4849.9 4864.7 4897.6 4809.0 4817.6 4819.9 4825.5 4829.6 4559.5 4659.1 4667.8 4669.9 4794.5 3523.4 3604.4 3860.3 3976.8 4157.4 6152.2 6222.6 6230.9 6272.0 6282.8 5766.8 5768.2 5771.2 5771.7 5788.8 6981.6 6985.0 6990.0 6999.4 6999.9 3925.6 4359.1 4593.4 4599.8 4610.8 7247.1 7364.1 7370.0 7395.2 7401.2 4664.0 4669.2 4678.8 4681.4 4695.5 3897.6 4739.6 4744.5 4745.0 4745.6 5607.3 5610.7 5613.0 5618.3 5618.6 6704.0 6947.5 6959.7 6967.7 7043.1 1624.4 1627.8 1640.9 1642.2 1645.0 1012.3 1030.3 1046.1 1055.7 1060.5 6349.5 6472.9 6624.7 6631.2 6644.0 7348.7 7359.3 7364.3 7367.8 7378.1 6583.9 6625.9 6626.2 6635.2 6636.4 3199.5 3786.9 3878.9 3881.7 3881.8 7341.3 7614.0 7622.5 7626.0 7629.9 6116.5 7498.2 7546.5 7549.3 7570.3 7021.6 7571.6 7585.6 7591.3 7600.5 5925.9 6516.9 7063.1 7338.5 7340.2 7191.0 7197.7 7200.5 7201.7 7210.7 7523.8 7563.6 7574.5 7579.1 7579.4 4682.0 4684.8 4690.5 4691.7 4695.1 7035.6 7264.6 7271.7 7275.3 7277.3 7041.6 7055.5 7059.8 7074.3 7083.7 6996.4 7041.4 7048.0 7054.0 7070.2 6886.9 6889.5 6892.2 6893.2 6894.6 5031.5 6753.7 7036.2 7053.4 7054.2 6673.2 6713.8 6911.9 6912.0 6933.1 16:41:01 INFO - PROCESS | 1667 | 16:41:01 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:18869.52 Median:53723.00 stddev:26703.56 (49.7%) stddev-sans-first:26743.71 16:41:01 INFO - PROCESS | 1667 | Values: 724.5 728.3 754.8 764.4 780.6 12091.3 14827.7 14941.0 15038.3 15071.3 13396.8 14476.6 14481.1 14483.8 14492.9 792.4 801.9 951.4 962.7 982.2 953.6 958.3 959.1 959.9 1000.3 1008.9 1009.5 1010.0 1011.2 1045.4 813.8 816.9 828.2 1018.4 1037.3 766.5 774.8 775.6 777.1 777.4 15115.8 15215.9 15216.6 15223.2 15246.6 12381.9 12430.4 12508.6 12689.7 12713.4 10146.2 10157.4 10239.3 10251.6 10484.6 3497.2 3557.4 3557.8 3613.9 3615.7 80424.2 82038.6 82154.6 82296.6 82650.6 9312.4 9598.3 9690.1 9746.7 9943.7 22093.8 22422.9 22430.4 22436.1 22466.1 7632.2 7689.0 7803.4 7977.3 7983.6 4208.5 4295.4 4302.5 4304.2 4493.6 3718.4 3764.1 3766.5 3768.8 3770.0 662.6 673.9 677.2 687.8 689.6 527.9 600.2 601.3 624.6 633.2 8287.8 8465.6 8490.3 8528.7 8621.7 524.2 561.6 596.0 607.1 624.6 3869.5 3933.2 3976.7 3988.9 4011.9 94612.0 95416.0 95452.5 95773.5 96007.0 82318.6 82612.0 82982.6 83007.0 84137.0 72512.6 72818.0 73055.0 73057.5 74923.6 7741.3 7854.8 8065.3 8065.5 8095.1 51835.0 52815.7 52869.7 53284.0 54162.0 59730.1 69110.3 69414.7 73563.6 74448.0 10325.8 10355.3 11123.0 11467.5 11748.6 11817.8 11923.9 11979.9 11990.4 12820.1 11315.7 11628.0 11730.4 11791.4 11925.9 11279.3 11645.7 11889.9 11942.6 12065.3 11124.9 11478.4 11573.5 11758.7 11782.9 9640.1 9652.8 9751.5 10033.5 10191.8 9264.4 9800.2 9829.4 9870.6 9895.6 16:41:01 INFO - PROCESS | 1667 | -------- Summary: end -------- 16:41:01 INFO - PROCESS | 1667 | 16:41:02 INFO - TEST-INFO | 1667: exit 0 16:41:02 INFO - TEST-OK | dromaeo_css | took 1112572ms 16:41:02 INFO - TEST-START | kraken 16:41:02 INFO - operating with platform_type : mac_ 16:41:02 INFO - Initialising browser for kraken test... 16:41:02 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmpJhJRdx/profile http://localhost:49270/getInfo.html) 16:41:04 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 16:41:04 INFO - PROCESS | 1673 | colorDepth:24 16:41:04 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 16:41:04 INFO - PROCESS | 1673 | __metrics 16:41:04 INFO - PROCESS | 1673 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:41:04 INFO - PROCESS | 1673 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:41:04 INFO - TEST-INFO | 1673: exit 0 16:41:04 INFO - Browser initialized. 16:41:04 INFO - Running cycle 1/1 for kraken test... 16:41:04 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmpJhJRdx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:41:16 INFO - PROCESS | 1675 | RSS: Main: 210542592 16:41:16 INFO - PROCESS | 1675 | 16:41:19 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 16:41:20 INFO - PROCESS | 1675 | RSS: Main: 264507392 16:41:20 INFO - PROCESS | 1675 | 16:41:22 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 16:41:23 INFO - PROCESS | 1675 | RSS: Main: 274337792 16:41:23 INFO - PROCESS | 1675 | 16:41:26 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 16:41:27 INFO - PROCESS | 1675 | RSS: Main: 264495104 16:41:27 INFO - PROCESS | 1675 | 16:41:28 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 16:41:29 INFO - PROCESS | 1675 | RSS: Main: 266723328 16:41:29 INFO - PROCESS | 1675 | 16:41:31 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:41:32 INFO - PROCESS | 1675 | RSS: Main: 267812864 16:41:32 INFO - PROCESS | 1675 | 16:41:34 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 16:41:35 INFO - PROCESS | 1675 | RSS: Main: 267591680 16:41:35 INFO - PROCESS | 1675 | 16:41:38 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 16:41:39 INFO - PROCESS | 1675 | RSS: Main: 267378688 16:41:39 INFO - PROCESS | 1675 | 16:41:41 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 16:41:42 INFO - PROCESS | 1675 | RSS: Main: 266543104 16:41:42 INFO - PROCESS | 1675 | 16:41:43 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:41:44 INFO - PROCESS | 1675 | RSS: Main: 301424640 16:41:44 INFO - PROCESS | 1675 | 16:41:46 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:41:46 INFO - PROCESS | 1675 | RSS: Main: 300744704 16:41:46 INFO - PROCESS | 1675 | 16:41:48 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:41:49 INFO - PROCESS | 1675 | RSS: Main: 306720768 16:41:49 INFO - PROCESS | 1675 | 16:41:52 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:41:52 INFO - PROCESS | 1675 | RSS: Main: 310640640 16:41:52 INFO - PROCESS | 1675 | 16:41:55 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:41:55 INFO - PROCESS | 1675 | RSS: Main: 309948416 16:41:55 INFO - PROCESS | 1675 | 16:41:57 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 16:41:57 INFO - PROCESS | 1675 | RSS: Main: 369786880 16:41:57 INFO - PROCESS | 1675 | 16:41:57 INFO - PROCESS | 1675 | __start_tp_report 16:41:57 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 16:41:57 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 16:41:57 INFO - PROCESS | 1675 | |i|pagename|runs| 16:41:57 INFO - PROCESS | 1675 | |0;ai-astar;112;109;110;110;113;112;120;153;162;115 16:41:57 INFO - PROCESS | 1675 | |1;audio-beat-detection;153;116;154;146;117;137;116;149;146;117 16:41:57 INFO - PROCESS | 1675 | |2;audio-dft;186;182;184;181;184;185;184;183;184;183 16:41:57 INFO - PROCESS | 1675 | |3;audio-fft;75;77;73;117;55;57;58;58;111;54 16:41:57 INFO - PROCESS | 1675 | |4;audio-oscillator;91;91;135;80;77;87;117;76;79;118 16:41:57 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;87;85;88;88;130;114;88;86;124;84 16:41:57 INFO - PROCESS | 1675 | |6;imaging-darkroom;107;149;148;94;93;92;92;93;92;92 16:41:57 INFO - PROCESS | 1675 | |7;imaging-desaturate;86;90;85;84;85;85;86;84;82;88 16:41:57 INFO - PROCESS | 1675 | |8;json-parse-financial;57;55;58;57;57;56;57;69;53;50 16:41:57 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;62;62;72;70;69;65;64;66;66;66 16:41:57 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;80;81;81;80;80;80;79;78;81;84 16:41:57 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;117;120;126;104;127;123;124;125;117;112 16:41:57 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;133;130;131;129;134;120;130;130;131;132 16:41:57 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;67;65;69;65;66;65;66;68;66;64 16:41:57 INFO - PROCESS | 1675 | __end_tp_report 16:41:57 INFO - PROCESS | 1675 | __start_cc_report 16:41:57 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1194 16:41:57 INFO - PROCESS | 1675 | __end_cc_report 16:41:57 INFO - PROCESS | 1675 | __startTimestamp1458603717547__endTimestamp 16:41:57 INFO - PROCESS | 1675 | 16:41:57 INFO - PROCESS | 1675 | ------- Summary: start ------- 16:41:57 INFO - PROCESS | 1675 | Number of tests: 14 16:41:57 INFO - PROCESS | 1675 | 16:41:57 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:121.60 Median:114.00 stddev:19.29 (16.9%) stddev-sans-first:20.15 16:41:57 INFO - PROCESS | 1675 | Values: 112.0 109.0 110.0 110.0 113.0 112.0 120.0 153.0 162.0 115.0 16:41:57 INFO - PROCESS | 1675 | 16:41:57 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:146.00 stddev:16.66 (11.4%) stddev-sans-first:16.36 16:41:57 INFO - PROCESS | 1675 | Values: 153.0 116.0 154.0 146.0 117.0 137.0 116.0 149.0 146.0 117.0 16:41:57 INFO - PROCESS | 1675 | 16:41:57 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.00 stddev:1.43 (0.8%) stddev-sans-first:1.22 16:41:57 INFO - PROCESS | 1675 | Values: 186.0 182.0 184.0 181.0 184.0 185.0 184.0 183.0 184.0 183.0 16:41:57 INFO - PROCESS | 1675 | 16:41:57 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:73.50 Median:58.00 stddev:23.07 (39.8%) stddev-sans-first:24.46 16:41:57 INFO - PROCESS | 1675 | Values: 75.0 77.0 73.0 117.0 55.0 57.0 58.0 58.0 111.0 54.0 16:41:57 INFO - PROCESS | 1675 | 16:41:57 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:79.50 stddev:20.75 (26.1%) stddev-sans-first:21.96 16:41:57 INFO - PROCESS | 1675 | Values: 91.0 91.0 135.0 80.0 77.0 87.0 117.0 76.0 79.0 118.0 16:41:57 INFO - PROCESS | 1675 | 16:41:57 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:97.40 Median:86.50 stddev:17.90 (20.7%) stddev-sans-first:18.58 16:41:57 INFO - PROCESS | 1675 | Values: 87.0 85.0 88.0 88.0 130.0 114.0 88.0 86.0 124.0 84.0 16:41:57 INFO - PROCESS | 1675 | 16:41:57 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:105.20 Median:92.00 stddev:23.27 (25.3%) stddev-sans-first:24.67 16:41:57 INFO - PROCESS | 1675 | Values: 107.0 149.0 148.0 94.0 93.0 92.0 92.0 93.0 92.0 92.0 16:41:57 INFO - PROCESS | 1675 | 16:41:57 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:85.50 stddev:2.22 (2.6%) stddev-sans-first:2.35 16:41:57 INFO - PROCESS | 1675 | Values: 86.0 90.0 85.0 84.0 85.0 85.0 86.0 84.0 82.0 88.0 16:41:57 INFO - PROCESS | 1675 | 16:41:57 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.00 stddev:4.89 (8.6%) stddev-sans-first:5.18 16:41:57 INFO - PROCESS | 1675 | Values: 57.0 55.0 58.0 57.0 57.0 56.0 57.0 69.0 53.0 50.0 16:41:57 INFO - PROCESS | 1675 | 16:41:57 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:3.29 (5.0%) stddev-sans-first:3.12 16:41:57 INFO - PROCESS | 1675 | Values: 62.0 62.0 72.0 70.0 69.0 65.0 64.0 66.0 66.0 66.0 16:41:57 INFO - PROCESS | 1675 | 16:41:57 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.50 stddev:1.58 (2.0%) stddev-sans-first:1.67 16:41:57 INFO - PROCESS | 1675 | Values: 80.0 81.0 81.0 80.0 80.0 80.0 79.0 78.0 81.0 84.0 16:41:57 INFO - PROCESS | 1675 | 16:41:57 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:119.50 Median:123.50 stddev:7.23 (5.9%) stddev-sans-first:7.61 16:41:57 INFO - PROCESS | 1675 | Values: 117.0 120.0 126.0 104.0 127.0 123.0 124.0 125.0 117.0 112.0 16:41:57 INFO - PROCESS | 1675 | 16:41:57 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:130.00 Median:131.00 stddev:3.83 (2.9%) stddev-sans-first:3.91 16:41:57 INFO - PROCESS | 1675 | Values: 133.0 130.0 131.0 129.0 134.0 120.0 130.0 130.0 131.0 132.0 16:41:57 INFO - PROCESS | 1675 | 16:41:57 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:1.52 (2.3%) stddev-sans-first:1.58 16:41:57 INFO - PROCESS | 1675 | Values: 67.0 65.0 69.0 65.0 66.0 65.0 66.0 68.0 66.0 64.0 16:41:57 INFO - PROCESS | 1675 | -------- Summary: end -------- 16:41:57 INFO - PROCESS | 1675 | 16:41:58 INFO - TEST-INFO | 1675: exit 0 16:41:58 INFO - TEST-OK | kraken | took 56224ms 16:41:58 INFO - SUITE-END | took 1168s 16:41:58 INFO - Completed test suite (00:19:29) 16:41:58 INFO - javascript benchmark 16:41:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3427.091820667523, 3483.947740783887, 3492.5808902931644, 3534.3991521441353, 3557.19963008323, 5701.6008879378405, 5730.79942202023, 5735.885282294362, 5742.167385729067, 5772.365039845619, 5728.198052272674, 5779.537636989041, 5781.4507621775865, 5788.6237394569325, 5792.275965504312, 5082.898342033157, 5155.690658560479, 5191.896162076766, 5223.033738758342, 5322.254884316179, 5216.113260745663, 5219.321488206528, 5223.947760522384, 5224.138017227153, 5230.450802665722, 5174.120399532069, 5198.168293073109, 5214.165733482643, 5217.34783152106, 5237.397699264595, 5196.506331898482, 5239.423663397023, 5244.895102097975, 5245.4754524547625, 5291.735413229323, 4502.829264391282, 4803.687760295569, 5152.639315247934, 5169.715665638389, 5182.0, 5474.808381706621, 5552.694601796899, 5564.8330550083565, 5594.0, 5594.104943209108, 6144.293406258293, 6224.813255602339, 6237.033259844731, 6238.875222495525, 6258.718357673915, 6181.289151747562, 6204.751809927598, 6246.469050130744, 6255.186825712628, 6266.373362663743, 5819.82540523785, 5827.009408400582, 5843.594674925719, 5874.647521148745, 5880.588358814927, 6156.907646385308, 6229.252489701174, 6249.9062514062325, 6261.154744109578, 6272.937270627326, 6179.16581261524, 6181.289151747606, 6185.195924529782, 6196.690165491707, 6203.96898015507, 6250.249970003629, 6252.124702541648, 6253.437190652772, 6256.186695729617, 6259.71831267594, 6016.939830601726, 6129.140113879657, 6133.737052748297, 6226.159468471698, 6249.218847644044, 6207.5654704171175, 6209.9068513972325, 6220.533459990519, 6240.126382306481, 6265.216847894013, 4886.53577910098, 4898.436679781799, 4898.485659005824, 4902.828401005948, 4942.5304596063315, 4417.911641767147, 4429.424174857312, 4431.534688857688, 4476.820927162877, 4486.798094085774, 4813.831515896997, 5702.372738998707, 5716.914246286309, 5723.055695810228, 5740.913886291709, 6160.075988601746, 6237.064440333896, 6243.656598887014, 6253.187085678924, 6266.937330626726, 4757.9286310705365, 5681.744321505542, 5706.80026199081, 5713.657180569096, 5730.598858079978, 5309.761060752198, 5313.654612450256, 5373.194020896896, 5388.784448622089, 5425.26758887553, 6276.372362763778, 6324.08300796382, 6328.208973878265, 6344.1118243445035, 6347.619142851444, 6336.366363363811, 6344.143540621957, 6357.745690172342, 6358.427741503102, 6368.554201206057, 6246.3753624637175, 6277.466415354746, 6283.465905397909, 6320.957042088188, 6346.238451385863, 6127.234095738033, 6162.506999440124, 6170.382961703794, 6226.470749986302, 6229.408206220402, 5345.732713364394, 6281.434670879643, 6314.0, 6322.589031712924, 6326.272478665012, 6011.098335249572, 6124.173236613178, 6140.140380346666, 6148.78479253224, 6149.2313460817395, 6131.254333328352, 6187.9480488317995, 6189.721462534107, 6193.783217587363, 6195.752169913153, 5142.794288228429, 5998.760049597967, 6000.219971403864, 6022.608530445507, 6042.244719410074, 5890.705464726832, 6043.909341359795, 6115.818436018264, 6128.662923539248, 6199.535034872312, 6072.089186622042, 6075.908861367171, 6088.269407671108, 6092.329843717099, 6098.0], "unit": "score", "name": "dojo.html", "value": 5697.052289602805}, {"lowerIsBetter": false, "replicates": [471.7429001194353, 582.1355287398213, 599.110321173058, 662.1689779326946, 669.7488441834312, 31181.532277015864, 31730.0, 31770.523442148387, 31775.205619859516, 39052.0, 42377.51678691246, 42696.57303426965, 42729.0, 42753.93115172122, 42898.0, 9587.185089267403, 9828.803423931517, 9835.557399916985, 9839.262055345878, 9882.703518894408, 9628.566714497865, 9764.90235097647, 9777.608895644202, 9784.315097943147, 9786.461744604045, 9728.756781080494, 9905.108540231378, 9907.0, 9917.057879501435, 9920.206383489303, 9797.412155270707, 9864.802703945952, 9875.259355548362, 9879.06148915859, 9881.308308418413, 9685.854712179253, 9834.655787047419, 9839.360441571347, 9844.852327215025, 9851.507424628811, 34152.6584734152, 41887.58112418867, 42099.1580168398, 42335.57664423347, 42418.78790606058, 3226.6612005739294, 3397.3545026445145, 3758.5489741230954, 3873.0898238913833, 3881.378979363288, 25500.617490737655, 29112.68992895325, 29261.97583084603, 29404.70595294041, 29450.0, 2682.7049024607277, 2702.0407755246997, 2732.9180124596296, 2737.7809775217934, 2743.7804975601903, 378225.0, 378682.0, 378896.0, 379351.0, 379493.0, 56720.865582688115, 66020.33979660238, 66946.33053669498, 67146.0, 67210.32789672041, 69528.3047169532, 76159.61920190364, 77490.22509774943, 77594.22405775983, 77632.61183694158, 18222.726659100124, 18396.080195990147, 18476.353327633467, 18610.720839187423, 18629.161687723812, 14080.647983800487, 14166.150030997967, 14179.007469477245, 14195.935304852177, 14217.715645687029, 21523.0, 21649.458763531038, 21732.674009889863, 21980.670289945665, 22044.33866983993, 9740.707778766648, 9905.158061564704, 10014.54934527948, 10020.0, 10055.29612927088, 971.9757006074905, 1035.30634474902, 1044.6604853422668, 1064.6805958212506, 1119.062723019581, 28984.565231521545, 30178.69821301803, 30438.0, 30504.38991220163, 30594.694053059186, 1183.662656142995, 1197.8323034774965, 1251.9061070419573, 1294.10706612439, 1302.2902518127644, 15118.773218401733, 15405.614859628598, 15442.691146177014, 15749.44876929302, 15802.60493487649, 546122.0, 548618.0, 550260.0, 550320.0, 551525.0, 61438.0784288236, 61980.38019619746, 62160.0, 62302.0, 62319.6884015577, 1422.5945605502588, 1549.6590750034975, 1551.9301631426613, 1568.404006477554, 1570.8507691769264, 28797.0, 29322.413551729274, 29504.967326143484, 29614.0, 30145.547816782328, 47135.764321178176, 47420.0, 47456.525434745214, 47482.151070935855, 47537.049259015315, 313776.0, 322472.0, 322539.0, 322856.0, 324673.0, 29857.95497157676, 48834.511654884416, 49723.75138124431, 50261.99476010386, 50892.0, 47581.52418475771, 48181.5181848177, 49106.50893491019, 49390.50609494003, 49542.0, 38752.287339887065, 39012.80493597514, 40680.79659601683, 41444.0, 42155.0, 32852.014439566854, 38415.6158438412, 39313.41029884611, 40223.79888100541, 40329.0, 39142.608573913894, 39351.60648393594, 39482.802585988036, 40568.78293651077, 40612.18775624412, 33556.496652549744, 35621.82189089038, 35783.64216357803, 36036.0, 37228.62771372252, 26661.333466663487, 27043.053493127645, 27075.0, 27165.320866978484, 27544.862275689295], "unit": "score", "name": "ext.html", "value": 20532.742715228353}, {"lowerIsBetter": false, "replicates": [349.0105550763585, 351.9225770330528, 383.81576843115306, 388.1499516059829, 392.1666458775103, 20005.099770510325, 20532.0, 20743.962801859903, 20771.065302061405, 21207.893960530175, 20706.171753129856, 20985.895070524664, 21365.572688546257, 21368.57262854742, 21886.671699924475, 5747.655140691561, 5981.49157321626, 5983.700814959257, 5990.49080828128, 6013.007853704134, 5759.884802303952, 5777.797777077803, 5959.851003724898, 5964.254468191476, 5974.103884417329, 5863.355030946593, 5887.0, 5891.381404952483, 5891.823245302648, 5895.852603684899, 5636.070048442002, 5780.335261444925, 5821.0, 5826.883462330729, 5878.353381128072, 5094.79620815167, 5111.974440127813, 5123.2827404163445, 5129.461406552333, 5132.84601461953, 25829.870850645813, 26353.73646263532, 26777.866110669518, 26783.866080669668, 26814.0, 2234.0377999195816, 2313.560423519543, 2369.869657168855, 2487.776100150977, 2797.146870204587, 15175.62060948474, 15302.540923772305, 15440.691186176326, 15553.844461555353, 15602.531924042298, 1736.2273788164273, 1772.3442326339336, 1795.6678014567347, 1824.6898027335385, 1825.7626508553935, 103651.0, 106401.0, 109170.45414772954, 109554.0, 109572.35641465384, 10993.175511836644, 11316.717082073013, 11439.142064345207, 11540.596079137358, 11634.825477617842, 13859.0, 13941.930290348484, 13987.37056832445, 13988.160710357412, 14001.0, 9024.774380640405, 9186.908130918606, 9201.539923003957, 9220.677276295432, 9312.813743725088, 9502.144806967406, 9507.429554226768, 9537.2370210383, 9618.278629102846, 9651.227901767841, 6594.043863639841, 6679.298673639295, 6702.128723265944, 6704.932950670431, 6767.323267673193, 1908.0061335904013, 1924.5284905198316, 1926.2391355414813, 1936.3997160880172, 1970.4088773367932, 425.23245541796734, 437.4946936288592, 981.6367943860818, 1059.1103473082494, 1089.128697042363, 11622.186446948632, 11899.631542372565, 11901.88098119025, 11978.221415607957, 12031.759364812655, 456.82412271275797, 474.62267497339695, 475.40811689446167, 490.2181021271067, 492.30093267560153, 5004.749762511859, 6098.35967223444, 6191.938080619227, 6214.378562143749, 6297.559170858088, 537687.0, 635191.0, 639651.0, 645941.0, 657018.0, 101050.0, 111297.0, 119202.0, 131621.0, 135090.97363539555, 427.8652224549257, 469.3499503188109, 473.9976300118477, 482.129755790794, 484.849696594057, 11491.367974761468, 11594.246373985665, 11624.535018599161, 11689.0, 11877.58428455, 39852.0, 51553.48446515487, 51858.0, 52953.47046529486, 53538.73230633822, 77452.0, 77583.22416775986, 77791.2220877784, 81087.59456202682, 81759.59120204361, 8360.623771930155, 8362.45644033136, 8368.665253389796, 8503.574821259035, 8696.826063478822, 11620.941895290469, 13278.136921100098, 13575.796363054365, 13654.86345136536, 13965.301734913011, 11405.885941140483, 11587.188896777481, 11720.0, 11722.472488738198, 11819.645410637351, 11557.711057223636, 11595.304281743123, 11635.825462618237, 11674.299542027165, 11823.704407389883, 10751.0324070834, 11050.0, 11642.94178529102, 11711.531538738354, 11828.763424731285, 8220.342372610057, 8252.546109964009, 8266.875996859932, 8339.45793523419, 8626.439281446686, 8744.05153929552, 11876.703082423008, 11916.463759130687, 12050.0, 12109.69725756863], "unit": "score", "name": "jquery.html", "value": 9024.885677015533}, {"lowerIsBetter": false, "replicates": [1542.1826431991049, 1683.8737094717897, 1710.4099085815394, 2078.3037682376403, 2122.4375540481765, 8434.776957341182, 8649.308055355572, 9084.818303633923, 9252.352335336529, 9260.58327375268, 9108.499032553207, 9123.270138388929, 9266.768330791734, 9268.814623707522, 9277.953610231956, 2205.9558808823813, 2262.8076613487874, 2557.283960491061, 2584.0955665517013, 2589.1196993022368, 2340.2511196417154, 2512.5854234051358, 2566.153169454076, 2570.485902819434, 2577.6004719268544, 2481.1192026830486, 2527.5576774064466, 2537.9746202538017, 2538.4669219463935, 2569.845809251451, 2509.962350564743, 2550.987245063772, 2555.2845203343095, 2561.871906404691, 2564.217913536371, 2200.878951657658, 2509.1970569417795, 2560.948781024369, 2563.512932542811, 2565.7690807827385, 9278.0, 9336.066393360677, 9338.206252468548, 9347.158755712018, 9348.67279645216, 5576.637518561281, 5742.712864356808, 5794.304683437972, 5798.797042103548, 5813.0, 3626.274745050974, 3627.6553727395853, 3781.5840257571645, 3784.6404591563755, 3790.77255364679, 1022.9948850255776, 1038.8857225705167, 1042.5725452564411, 1054.9894501054969, 1059.6079450603327, 12697.873021269761, 12703.872961270361, 12714.427850746739, 12716.618501444971, 12723.773339665615, 4322.589354011364, 5027.673201241908, 5112.539871411591, 5129.384473863161, 5137.768800403991, 10603.84094238587, 10692.679219623424, 10694.251402401756, 10696.304740192018, 10701.25091243621, 5139.254808052886, 5505.119180931032, 5766.365699773021, 5766.567507436959, 5773.624714393551, 3887.3002859485564, 4629.166749984967, 5220.791168353223, 5221.7128057956415, 5231.084560202025, 3844.1735026969336, 3959.366501359769, 4036.3541833307117, 4142.542929566926, 4197.118605092965, 1348.211296391622, 1349.5748839115647, 1355.8983076269121, 1357.5655790147255, 1363.1548439967285, 1148.5176225985106, 1166.4634268236707, 1260.9912070343871, 1420.5170242117729, 1446.4864972934668, 8591.398602097917, 8652.783680407914, 8654.697085601974, 8675.089115642893, 8681.956590217134, 1248.3508575540668, 1253.4422182129047, 1260.426505939795, 1269.6571925580042, 1278.5397256987478, 6419.454346380517, 6444.387783160592, 6546.247181574085, 6551.246606640298, 6568.80293591193, 10873.184511161695, 11309.604163854226, 11350.716232094099, 11499.827502587468, 11513.942430287794, 8780.473171609596, 11225.989660930556, 11324.433778311051, 11405.771884562262, 11410.714732131763, 8726.86909696355, 8750.912490875136, 8755.824883502295, 8783.780405490043, 8871.64513419456, 8178.386621003329, 8249.587520624065, 8298.917010829815, 8321.251087402163, 8337.541435221121, 8281.958590207252, 10108.938561450941, 10133.240006999356, 10144.340617859816, 10157.746056348651, 10430.947845260725, 10613.734656633645, 10638.095761860328, 10680.679579612624, 10802.0, 7602.7339043133225, 7807.219278072374, 7827.569483678452, 7829.177936316605, 7842.0, 7814.843703126019, 8310.958445207736, 8525.062243153372, 8527.10465401124, 8556.614952327285, 7452.590107544137, 7592.126905405949, 7624.123225829101, 7653.961730191313, 7700.537967721954, 7547.50941188821, 7552.244775522404, 7585.582792946441, 7664.156942736183, 7677.155512893689, 7915.84168316642, 8009.038915330198, 8040.718574849852, 8044.3162331200165, 8155.9184408157535, 7235.131784185932, 7274.745383911538, 7349.963250183715, 7354.8896766549615, 7358.484906056525, 7435.553866768011, 7524.849503009799, 7526.360259378014, 7530.623468826428, 7540.622968851645], "unit": "score", "name": "mootools.html", "value": 5152.358984484433}, {"lowerIsBetter": false, "replicates": [336.68351749355605, 340.8636545381847, 345.4973014264246, 348.0741228332636, 350.2102758280078, 6597.769078082268, 6608.107905432771, 6620.9006864897, 6649.401553860152, 6697.0289308050305, 6533.803985880431, 6535.0, 6544.247411547662, 6550.5742126761725, 6560.967195164029, 4657.161710892038, 4727.1254817858635, 4759.7144171349655, 4861.513848615145, 4902.240152776325, 4833.661643684944, 4849.369581954358, 4849.878753031167, 4864.708117512942, 4897.559219670229, 4809.038192361541, 4817.566419022287, 4819.855404337858, 4825.469198388175, 4829.623557286174, 4559.475660299075, 4659.1147681940665, 4667.766611669437, 4669.859904202863, 4794.544518270759, 3523.4010218262956, 3604.42329227325, 3860.305145073886, 3976.846714452834, 4157.417961485395, 6152.200748659349, 6222.595531290452, 6230.937690623081, 6271.968640156816, 6282.780102696383, 5766.826995190151, 5768.163616275617, 5771.192033115367, 5771.682557459338, 5788.797392091256, 6981.581105133709, 6984.965075174642, 6989.965050174767, 6999.440044796404, 6999.930000699978, 3925.60743925608, 4359.149965756678, 4593.425821772278, 4599.770011499445, 4610.792514336863, 7247.094113235846, 7364.116306043309, 7370.041894553728, 7395.2235015323695, 7401.185869554345, 4663.953360466352, 4669.229577119805, 4678.812847486062, 4681.391419115494, 4695.483496815347, 3897.61023897608, 4739.644526660514, 4744.501827308152, 4745.0, 4745.596624286905, 5607.299087614048, 5610.663360198401, 5613.0, 5618.269624948731, 5618.606697531133, 6704.0, 6947.51367404287, 6959.652017399211, 6967.686454109577, 7043.119610048744, 1624.4395683489176, 1627.7802496663037, 1640.9425670101489, 1642.24456749894, 1645.0, 1012.2711647613706, 1030.3096925060227, 1046.1160319529986, 1055.6621880998007, 1060.5439660945713, 6349.492040636738, 6472.870542589122, 6624.701888415033, 6631.237407698177, 6643.966780166165, 7348.669309881068, 7359.264073592598, 7364.2635736427, 7367.77896663101, 7378.077740282465, 6583.868322633521, 6625.933740662628, 6626.237982632059, 6635.2037755469655, 6636.402723754885, 3199.504076868089, 3786.8674596388996, 3878.903027424337, 3881.6700580450415, 3881.8059097045034, 7341.3392794648735, 7614.048243969504, 7622.542647441061, 7625.961870190614, 7629.8855517167285, 6116.480099191618, 7498.212687667826, 7546.5094768840945, 7549.282818132378, 7570.318671319607, 7021.630781997462, 7571.583562904093, 7585.58279294633, 7591.278828511283, 7600.543967361976, 5925.9407405925385, 6516.902246466401, 7063.081799366049, 7338.486305958745, 7340.15588207363, 7190.96404517974, 7197.676104575202, 7200.531965422231, 7201.747938822116, 7210.74762383335, 7523.774286771406, 7563.621818908922, 7574.545527268381, 7579.1284002340435, 7579.431542634215, 4681.953180468152, 4684.789184486638, 4690.507496712932, 4691.671582989295, 4695.084458530554, 7035.648217589202, 7264.600446975256, 7271.672774725044, 7275.272472752894, 7277.345038946521, 7041.612711300722, 7055.4708396871465, 7059.788206353817, 7074.327938845801, 7083.716651333889, 6996.370326670624, 7041.401480874183, 7047.964760176166, 7054.0, 7070.1869285030825, 6886.8622627548175, 6889.483288753263, 6892.207396149507, 6893.172819261721, 6894.551854129466, 5031.471695471922, 6753.729850805913, 7036.2260151384335, 7053.400460960671, 7054.153501579844, 6673.165854268216, 6713.798586042427, 6911.896321555281, 6912.0, 6933.128055425108], "unit": "score", "name": "prototype.html", "value": 5114.795400726852}, {"lowerIsBetter": false, "replicates": [724.4675163754639, 728.3044692318836, 754.8075240813594, 764.3923081150485, 780.5823884221942, 12091.274523528573, 14827.703445931089, 14941.0, 15038.323275452603, 15071.321790519425, 13396.799048014287, 14476.5657030289, 14481.058731182493, 14483.782743258833, 14492.855071449283, 792.3502727763237, 801.9238172373645, 951.3720944176845, 962.7448726087592, 982.2485798364221, 953.5708930981051, 958.2860768727273, 959.1080295325345, 959.8800149981253, 1000.334777373046, 1008.8738907636546, 1009.5204777730593, 1010.0051449322448, 1011.1708399112731, 1045.3884477580625, 813.8494378539959, 816.8938038055074, 828.2214718164936, 1018.3991445047458, 1037.2790910317333, 766.5247546521136, 774.8295375017543, 775.5850619918317, 777.0519965641907, 777.4169372970272, 15115.848841511553, 15215.923920380328, 15216.619584510365, 15223.162726050063, 15246.618834529114, 12381.876181238162, 12430.378481076, 12508.624741257685, 12689.746205075939, 12713.364331783374, 10146.235961744522, 10157.441340726256, 10239.283250172492, 10251.589936402535, 10484.633037843716, 3497.24809166028, 3557.4130268505924, 3557.7865328080397, 3613.927721445583, 3615.6745892869767, 80424.19575804226, 82038.58980705118, 82154.58922705348, 82296.58851705764, 82650.58674706648, 9312.441253524674, 9598.32811703188, 9690.079442452956, 9746.707598772047, 9943.651972180938, 22093.779062209494, 22422.87885605713, 22430.439239019153, 22436.10255589791, 22466.10135594558, 7632.188009535319, 7688.961555192188, 7803.375729941591, 7977.3219276361, 7983.640736166886, 4208.537060923296, 4295.4201182839915, 4302.548232435612, 4304.160688665743, 4493.573110554492, 3718.3678774608384, 3764.1342491226624, 3766.472693822867, 3768.811559422018, 3769.981150094287, 662.6421732264523, 673.9452756436161, 677.1873751498222, 687.8039758668756, 689.565573688573, 527.9208118782213, 600.2197143713155, 601.3295175878864, 624.6002558362652, 633.2021652717609, 8287.751367458986, 8465.619047142893, 8490.27832634233, 8528.714567438861, 8621.684541456916, 524.2477045439806, 561.6349372907642, 595.9553033522417, 607.1499900139752, 624.6127401011402, 3869.5163104611925, 3933.1936952925153, 3976.687693061283, 3988.920221595552, 4011.8997025074605, 94612.0, 95416.0, 95452.52273738726, 95773.52113239389, 96007.0399296012, 82318.58840705758, 82612.0, 82982.58508707419, 83007.0, 84137.0, 72512.63743681248, 72818.0, 73054.99999999894, 73057.53884922378, 74923.62538187383, 7741.264579864904, 7854.803629909298, 8065.274125328749, 8065.475744076616, 8095.069067057364, 51835.0, 52815.73592132015, 52869.7356513215, 53284.0, 54162.0, 59730.104048438436, 69110.3088969124, 69414.65292673504, 73563.63218183875, 74448.0, 10325.845112323172, 10355.326903751233, 11122.99893009633, 11467.541298347973, 11748.588799392322, 11817.822732658846, 11923.940380298043, 11979.940100299442, 11990.448236406288, 12820.102592818414, 11315.660530184108, 11628.0, 11730.413479326171, 11791.35147566892, 11925.880741192825, 11279.342839306744, 11645.717510655924, 11889.929906308475, 11942.582009629621, 12065.336406497727, 11124.944375278072, 11478.368689722145, 11573.537058517564, 11758.70603234926, 11782.941085294518, 9640.132388084825, 9652.806943860944, 9751.51242437861, 10033.498325083863, 10191.796164076824, 9264.44413335202, 9800.166985806287, 9829.361091529314, 9870.555824987749, 9895.604175832887], "unit": "score", "name": "yui.html", "value": 7085.149121378347}], "name": "dromaeo_css", "value": 7628.856518211689}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 110.0, 110.0, 113.0, 112.0, 120.0, 153.0, 162.0, 115.0], "unit": "score", "name": "ai-astar", "value": 121.6}, {"lowerIsBetter": true, "replicates": [153.0, 116.0, 154.0, 146.0, 117.0, 137.0, 116.0, 149.0, 146.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 135.1}, {"lowerIsBetter": true, "replicates": [186.0, 182.0, 184.0, 181.0, 184.0, 185.0, 184.0, 183.0, 184.0, 183.0], "unit": "score", "name": "audio-dft", "value": 183.6}, {"lowerIsBetter": true, "replicates": [75.0, 77.0, 73.0, 117.0, 55.0, 57.0, 58.0, 58.0, 111.0, 54.0], "unit": "score", "name": "audio-fft", "value": 73.5}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 135.0, 80.0, 77.0, 87.0, 117.0, 76.0, 79.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 95.1}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 88.0, 88.0, 130.0, 114.0, 88.0, 86.0, 124.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 97.4}, {"lowerIsBetter": true, "replicates": [107.0, 149.0, 148.0, 94.0, 93.0, 92.0, 92.0, 93.0, 92.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 105.2}, {"lowerIsBetter": true, "replicates": [86.0, 90.0, 85.0, 84.0, 85.0, 85.0, 86.0, 84.0, 82.0, 88.0], "unit": "score", "name": "imaging-desaturate", "value": 85.5}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 58.0, 57.0, 57.0, 56.0, 57.0, 69.0, 53.0, 50.0], "unit": "score", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 72.0, 70.0, 69.0, 65.0, 64.0, 66.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.2}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 81.0, 80.0, 80.0, 80.0, 79.0, 78.0, 81.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.4}, {"lowerIsBetter": true, "replicates": [117.0, 120.0, 126.0, 104.0, 127.0, 123.0, 124.0, 125.0, 117.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.5}, {"lowerIsBetter": true, "replicates": [133.0, 130.0, 131.0, 129.0, 134.0, 120.0, 130.0, 130.0, 131.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 130.0}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 69.0, 65.0, 66.0, 65.0, 66.0, 68.0, 66.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1416.1}]} 16:41:58 INFO - Return code: 0 16:41:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:41:58 INFO - # TBPL SUCCESS # 16:41:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:41:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:41:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:41:58 INFO - 2016-03-21 16:41:58.869 screenresolution[1679:9745] starting screenresolution argv=screenresolution get 16:41:58 INFO - 2016-03-21 16:41:58.872 screenresolution[1679:9745] Display 0: 1600x1200x32@60 16:41:58 INFO - 2016-03-21 16:41:58.878 screenresolution[1680:9748] starting screenresolution argv=screenresolution list 16:41:58 INFO - Available Modes on Display 0 16:41:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:41:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:41:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:41:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:41:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:41:59 INFO - Intel Iris: 16:41:59 INFO - Chipset Model: Intel Iris 16:41:59 INFO - Type: GPU 16:41:59 INFO - Bus: Built-In 16:41:59 INFO - VRAM (Dynamic, Max): 1536 MB 16:41:59 INFO - Vendor: Intel (0x8086) 16:41:59 INFO - Device ID: 0x0a2e 16:41:59 INFO - Revision ID: 0x0009 16:41:59 INFO - Displays: 16:41:59 INFO - Display: 16:41:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:41:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:41:59 INFO - Display Serial Number: 1600x1200 60 16:41:59 INFO - Main Display: Yes 16:41:59 INFO - Mirror: Off 16:41:59 INFO - Online: Yes 16:41:59 INFO - Rotation: Supported 16:41:59 INFO - Return code: 0 16:41:59 INFO - Running post-action listener: _resource_record_post_action 16:41:59 INFO - Running post-run listener: _resource_record_post_run 16:42:00 INFO - Total resource usage - Wall time: 1203s; CPU: 52.0%; Read bytes: 32202240; Write bytes: 665339904; Read time: 324; Write time: 1759 16:42:00 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 356022784; Write bytes: 354105344; Read time: 27558; Write time: 658 16:42:00 INFO - run-tests - Wall time: 1171s; CPU: 52.0%; Read bytes: 30395904; Write bytes: 300060672; Read time: 304; Write time: 1070 16:42:00 INFO - Running post-run listener: _upload_blobber_files 16:42:00 INFO - Blob upload gear active. 16:42:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:42:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:42:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:42:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:42:00 INFO - (blobuploader) - INFO - Open directory for files ... 16:42:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:42:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:42:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:42:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:42:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:42:01 INFO - (blobuploader) - INFO - Done attempting. 16:42:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:42:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:42:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:42:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:42:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:42:02 INFO - (blobuploader) - INFO - Done attempting. 16:42:02 INFO - (blobuploader) - INFO - Iteration through files over. 16:42:02 INFO - Return code: 0 16:42:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:42:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:42:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3df3f613058acad32604698b6402581d71d8c0303edc4d78ab5221d0920c49e3f4de4b7ef37fe7c6d674ae550479f3000febb763b8b2a67376c7fc6fcb2473de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c9d96aec088cd03578aba71485b0125b3cd6ef2b7596cacb774c248943c1f1400c0c430a53e87dcd22f2199c8a8153c2f13aabbc0ae8792b62a9d98b0008d933"} 16:42:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:42:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:42:02 INFO - Contents: 16:42:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3df3f613058acad32604698b6402581d71d8c0303edc4d78ab5221d0920c49e3f4de4b7ef37fe7c6d674ae550479f3000febb763b8b2a67376c7fc6fcb2473de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c9d96aec088cd03578aba71485b0125b3cd6ef2b7596cacb774c248943c1f1400c0c430a53e87dcd22f2199c8a8153c2f13aabbc0ae8792b62a9d98b0008d933"} 16:42:02 INFO - Running post-run listener: copy_logs_to_upload_dir 16:42:02 INFO - Copying logs to upload dir... 16:42:02 INFO - mkdir: /builds/slave/test/build/upload/logs 16:42:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.379981 ========= master_lag: 1.26 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-21 16:42:02.471007) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 16:42:02.475870) ========= 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.W0GVmcJMR5/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.jkriioW7M9/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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/3df3f613058acad32604698b6402581d71d8c0303edc4d78ab5221d0920c49e3f4de4b7ef37fe7c6d674ae550479f3000febb763b8b2a67376c7fc6fcb2473de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c9d96aec088cd03578aba71485b0125b3cd6ef2b7596cacb774c248943c1f1400c0c430a53e87dcd22f2199c8a8153c2f13aabbc0ae8792b62a9d98b0008d933"} build_url:https://queue.taskcluster.net/v1/task/T_yfOl2NQHiTDREmjzfhlQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011275 build_url: 'https://queue.taskcluster.net/v1/task/T_yfOl2NQHiTDREmjzfhlQ/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/3df3f613058acad32604698b6402581d71d8c0303edc4d78ab5221d0920c49e3f4de4b7ef37fe7c6d674ae550479f3000febb763b8b2a67376c7fc6fcb2473de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c9d96aec088cd03578aba71485b0125b3cd6ef2b7596cacb774c248943c1f1400c0c430a53e87dcd22f2199c8a8153c2f13aabbc0ae8792b62a9d98b0008d933"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 16:42:02.514269) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 16:42:02.514598) ========= 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.W0GVmcJMR5/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.jkriioW7M9/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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.005202 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 16:42:02.567797) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 16:42:02.568103) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 16:42:02.571497) ========= ========= Total master_lag: 26.60 =========