builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0111 starttime: 1458837583.19 results: success (0) buildid: 20160324073337 builduid: ad8d0b56b54848aeb321b9102437ca4b revision: 54836a65a622ddbefa6dd19b1a33168f392dab72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 09:39:43.193001) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 09:39:43.193414) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 09:39:43.193699) ========= 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.53dtWUXQxF/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.LFyasPIJXH/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.005409 basedir: '/builds/slave/test' ========= master_lag: 0.46 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 09:39:43.663600) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 09:39:43.663916) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 09:39:44.263331) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:39:44.263665) ========= 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.53dtWUXQxF/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.LFyasPIJXH/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.005681 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:39:44.321268) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 09:39:44.321578) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 09:39:44.321926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:39:44.322197) ========= 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.53dtWUXQxF/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.LFyasPIJXH/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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-24 09:39:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.3M=0.001s 2016-03-24 09:39:44 (13.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137097 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:39:44.591015) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:39:44.591290) ========= 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.53dtWUXQxF/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.LFyasPIJXH/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.028312 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:39:44.648241) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 09:39:44.648575) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 54836a65a622ddbefa6dd19b1a33168f392dab72 --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 54836a65a622ddbefa6dd19b1a33168f392dab72 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.53dtWUXQxF/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.LFyasPIJXH/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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-24 09:39:44,734 truncating revision to first 12 chars 2016-03-24 09:39:44,734 Setting DEBUG logging. 2016-03-24 09:39:44,734 attempt 1/10 2016-03-24 09:39:44,734 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/54836a65a622?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-24 09:39:45,487 unpacking tar archive at: mozilla-aurora-54836a65a622/testing/mozharness/ program finished with exit code 0 elapsedTime=0.997703 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 09:39:45.667524) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 09:39:45.667877) ========= echo 54836a65a622ddbefa6dd19b1a33168f392dab72 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'54836a65a622ddbefa6dd19b1a33168f392dab72'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.53dtWUXQxF/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.LFyasPIJXH/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 54836a65a622ddbefa6dd19b1a33168f392dab72 program finished with exit code 0 elapsedTime=0.005601 script_repo_revision: '54836a65a622ddbefa6dd19b1a33168f392dab72' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 09:39:45.718096) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 09:39:45.718402) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 09:39:45.732906) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-03-24 09:39:45.733283) ========= /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.53dtWUXQxF/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.LFyasPIJXH/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 09:39:45 INFO - MultiFileLogger online at 20160324 09:39:45 in /builds/slave/test 09:39:45 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 09:39:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:39:45 INFO - {'append_to_log': False, 09:39:45 INFO - 'base_work_dir': '/builds/slave/test', 09:39:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:39:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:39:45 INFO - 'branch': 'Mozilla-Aurora', 09:39:45 INFO - 'buildbot_json_path': 'buildprops.json', 09:39:45 INFO - 'config_files': ('talos/mac_config.py',), 09:39:45 INFO - 'default_actions': ('clobber', 09:39:45 INFO - 'read-buildbot-config', 09:39:45 INFO - 'download-and-extract', 09:39:45 INFO - 'populate-webroot', 09:39:45 INFO - 'create-virtualenv', 09:39:45 INFO - 'install', 09:39:45 INFO - 'run-tests'), 09:39:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:39:45 INFO - 'download_minidump_stackwalk': True, 09:39:45 INFO - 'download_symbols': 'ondemand', 09:39:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:39:45 INFO - 'tooltool.py': '/tools/tooltool.py', 09:39:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:39:45 INFO - '/tools/misc-python/virtualenv.py')}, 09:39:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:39:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:39:45 INFO - 'installer_path': 'installer.exe', 09:39:45 INFO - 'log_level': 'info', 09:39:45 INFO - 'log_name': 'talos', 09:39:45 INFO - 'log_to_console': True, 09:39:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:39:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:39:45 INFO - 'opt_config_files': (), 09:39:45 INFO - 'pip_index': False, 09:39:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:39:45 INFO - 'cmd': ('bash', 09:39:45 INFO - '-c', 09:39:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:39:45 INFO - 'enabled': True, 09:39:45 INFO - 'halt_on_failure': False, 09:39:45 INFO - 'name': 'check_screen_resolution'},), 09:39:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:39:45 INFO - 'cmd': ('bash', 09:39:45 INFO - '-c', 09:39:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:39:45 INFO - 'enabled': True, 09:39:45 INFO - 'halt_on_failure': False, 09:39:45 INFO - 'name': 'check_screen_resolution'},), 09:39:45 INFO - 'run_cmd_checks_enabled': True, 09:39:45 INFO - 'sps_profile': False, 09:39:45 INFO - 'sps_profile_interval': 0, 09:39:45 INFO - 'suite': 'dromaeojs', 09:39:45 INFO - 'system_bits': '32', 09:39:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:39:45 INFO - 'title': 't-yosemite-r7-0111', 09:39:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:39:45 INFO - 'use_talos_json': True, 09:39:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:39:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:39:45 INFO - 'work_dir': 'build'} 09:39:45 INFO - ##### 09:39:45 INFO - ##### Running clobber step. 09:39:45 INFO - ##### 09:39:45 INFO - Running pre-action listener: _resource_record_pre_action 09:39:45 INFO - Running main action method: clobber 09:39:45 INFO - rmtree: /builds/slave/test/build 09:39:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:39:47 INFO - Running post-action listener: _resource_record_post_action 09:39:47 INFO - ##### 09:39:47 INFO - ##### Running read-buildbot-config step. 09:39:47 INFO - ##### 09:39:47 INFO - Running pre-action listener: _resource_record_pre_action 09:39:47 INFO - Running main action method: read_buildbot_config 09:39:47 INFO - Using buildbot properties: 09:39:47 INFO - { 09:39:47 INFO - "project": "", 09:39:47 INFO - "product": "firefox", 09:39:47 INFO - "script_repo_revision": "production", 09:39:47 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:39:47 INFO - "repository": "", 09:39:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:39:47 INFO - "buildid": "20160324073337", 09:39:47 INFO - "pgo_build": "False", 09:39:47 INFO - "basedir": "/builds/slave/test", 09:39:47 INFO - "buildnumber": 238, 09:39:47 INFO - "slavename": "t-yosemite-r7-0111", 09:39:47 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:39:47 INFO - "platform": "yosemite_r7", 09:39:47 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:39:47 INFO - "branch": "mozilla-aurora", 09:39:47 INFO - "repo_path": "releases/mozilla-aurora", 09:39:47 INFO - "revision": "54836a65a622ddbefa6dd19b1a33168f392dab72", 09:39:47 INFO - "stage_platform": "macosx64", 09:39:47 INFO - "builduid": "ad8d0b56b54848aeb321b9102437ca4b", 09:39:47 INFO - "slavebuilddir": "test" 09:39:47 INFO - } 09:39:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/X4gfkRzVQy-yftBSNYiC1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 09:39:47 INFO - Running post-action listener: _resource_record_post_action 09:39:47 INFO - ##### 09:39:47 INFO - ##### Running download-and-extract step. 09:39:47 INFO - ##### 09:39:47 INFO - Running pre-action listener: _resource_record_pre_action 09:39:47 INFO - Running main action method: download_and_extract 09:39:47 INFO - mkdir: /builds/slave/test/build/tests 09:39: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')]} 09:39:47 INFO - https://queue.taskcluster.net/v1/task/X4gfkRzVQy-yftBSNYiC1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:39:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4gfkRzVQy-yftBSNYiC1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 09:39:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4gfkRzVQy-yftBSNYiC1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 09:39:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4gfkRzVQy-yftBSNYiC1Q/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 09:39:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4gfkRzVQy-yftBSNYiC1Q/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 09:39:50 INFO - Downloaded 1277 bytes. 09:39:50 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 09:39:50 INFO - Using the following test package requirements: 09:39:50 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 09:39:50 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:39:50 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 09:39:50 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:39:50 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 09:39:50 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:39:50 INFO - u'jsshell-mac.zip'], 09:39:50 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:39:50 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 09:39:50 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 09:39:50 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:39:50 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 09:39:50 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:39:50 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 09:39:50 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:39:50 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 09:39:50 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 09:39:50 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:39:50 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 09:39:50 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:39:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:50 INFO - https://queue.taskcluster.net/v1/task/X4gfkRzVQy-yftBSNYiC1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:39:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4gfkRzVQy-yftBSNYiC1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 09:39:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4gfkRzVQy-yftBSNYiC1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 09:39:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4gfkRzVQy-yftBSNYiC1Q/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 09:39:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4gfkRzVQy-yftBSNYiC1Q/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 09:39:52 INFO - Downloaded 17869021 bytes. 09:39:52 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'] 09:39:52 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 09:39:55 INFO - Return code: 0 09:39:55 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 09:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:55 INFO - https://queue.taskcluster.net/v1/task/X4gfkRzVQy-yftBSNYiC1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:39:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4gfkRzVQy-yftBSNYiC1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 09:39:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4gfkRzVQy-yftBSNYiC1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 09:39:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4gfkRzVQy-yftBSNYiC1Q/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 09:39:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4gfkRzVQy-yftBSNYiC1Q/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 09:39:58 INFO - Downloaded 17869021 bytes. 09:39:58 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'] 09:39:58 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 09:40:02 INFO - Return code: 0 09:40: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')]} 09:40:02 INFO - https://queue.taskcluster.net/v1/task/X4gfkRzVQy-yftBSNYiC1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:40:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4gfkRzVQy-yftBSNYiC1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 09:40:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4gfkRzVQy-yftBSNYiC1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 09:40:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4gfkRzVQy-yftBSNYiC1Q/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 09:40:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4gfkRzVQy-yftBSNYiC1Q/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 09:40:04 INFO - Downloaded 10845161 bytes. 09:40:04 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'] 09:40:04 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 09:40:04 INFO - Return code: 0 09:40: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')]} 09:40:04 INFO - https://queue.taskcluster.net/v1/task/X4gfkRzVQy-yftBSNYiC1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 09:40:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4gfkRzVQy-yftBSNYiC1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 09:40:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4gfkRzVQy-yftBSNYiC1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 09:40:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4gfkRzVQy-yftBSNYiC1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 09:40:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4gfkRzVQy-yftBSNYiC1Q/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 09:40:07 INFO - Downloaded 114965223 bytes. 09:40:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X4gfkRzVQy-yftBSNYiC1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 09:40:07 INFO - mkdir: /builds/slave/test/properties 09:40:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:40:07 INFO - Writing to file /builds/slave/test/properties/build_url 09:40:07 INFO - Contents: 09:40:07 INFO - build_url:https://queue.taskcluster.net/v1/task/X4gfkRzVQy-yftBSNYiC1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 09:40:08 INFO - Running post-action listener: _resource_record_post_action 09:40:08 INFO - Running post-action listener: set_extra_try_arguments 09:40:08 INFO - ##### 09:40:08 INFO - ##### Running populate-webroot step. 09:40:08 INFO - ##### 09:40:08 INFO - Running pre-action listener: _resource_record_pre_action 09:40:08 INFO - Running main action method: populate_webroot 09:40:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:40:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:40:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:40:08 INFO - '--tppagecycles', 09:40:08 INFO - '7'], 09:40:08 INFO - 'tests': ['tsvgm']}}, 09:40:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:40:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:40:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:40:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:40:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:40:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:40:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:40:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:08 INFO - 'talos_options': ['--e10s'], 09:40:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:40:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:08 INFO - 'tests': ['damp', 'tps']}, 09:40:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:08 INFO - 'talos_options': ['--e10s'], 09:40:08 INFO - 'tests': ['damp', 'tps']}, 09:40:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:40:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:40:08 INFO - 'other': {'tests': ['a11yr', 09:40:08 INFO - 'ts_paint', 09:40:08 INFO - 'tpaint', 09:40:08 INFO - 'sessionrestore', 09:40:08 INFO - 'sessionrestore_no_auto_restore', 09:40:08 INFO - 'tabpaint']}, 09:40:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:40:08 INFO - 'tests': ['a11yr', 09:40:08 INFO - 'ts_paint', 09:40:08 INFO - 'tpaint', 09:40:08 INFO - 'sessionrestore', 09:40:08 INFO - 'sessionrestore_no_auto_restore', 09:40:08 INFO - 'tabpaint']}, 09:40:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:40:08 INFO - 'tests': ['a11yr', 09:40:08 INFO - 'ts_paint', 09:40:08 INFO - 'tpaint', 09:40:08 INFO - 'sessionrestore', 09:40:08 INFO - 'sessionrestore_no_auto_restore', 09:40:08 INFO - 'tabpaint']}, 09:40:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:40:08 INFO - 'tests': ['a11yr', 09:40:08 INFO - 'ts_paint', 09:40:08 INFO - 'tpaint', 09:40:08 INFO - 'sessionrestore', 09:40:08 INFO - 'sessionrestore_no_auto_restore', 09:40:08 INFO - 'tabpaint']}, 09:40:08 INFO - 'other_l64': {'tests': ['a11yr', 09:40:08 INFO - 'ts_paint', 09:40:08 INFO - 'tpaint', 09:40:08 INFO - 'sessionrestore', 09:40:08 INFO - 'sessionrestore_no_auto_restore', 09:40:08 INFO - 'tabpaint']}, 09:40:08 INFO - 'other_nol64': {'tests': ['a11yr', 09:40:08 INFO - 'ts_paint', 09:40:08 INFO - 'tpaint', 09:40:08 INFO - 'sessionrestore', 09:40:08 INFO - 'sessionrestore_no_auto_restore', 09:40:08 INFO - 'tabpaint']}, 09:40:08 INFO - 'svgr': {'tests': ['tsvgx', 09:40:08 INFO - 'tsvgr_opacity', 09:40:08 INFO - 'tart', 09:40:08 INFO - 'tscrollx', 09:40:08 INFO - 'cart']}, 09:40:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:40:08 INFO - 'tests': ['tsvgx', 09:40:08 INFO - 'tsvgr_opacity', 09:40:08 INFO - 'tart', 09:40:08 INFO - 'tscrollx', 09:40:08 INFO - 'cart']}, 09:40:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:08 INFO - 'tests': ['tp5o']}, 09:40:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:08 INFO - 'talos_options': ['--e10s'], 09:40:08 INFO - 'tests': ['tp5o']}, 09:40:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:08 INFO - 'talos_options': ['--xperf_path', 09:40:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:40:08 INFO - 'tests': ['tp5n']}, 09:40:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:08 INFO - 'talos_options': ['--e10s', 09:40:08 INFO - '--xperf_path', 09:40:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:40:08 INFO - 'tests': ['tp5n']}}, 09:40:08 INFO - 'talos.zip': {'path': '', 09:40:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:40:08 INFO - Running post-action listener: _resource_record_post_action 09:40:08 INFO - ##### 09:40:08 INFO - ##### Running create-virtualenv step. 09:40:08 INFO - ##### 09:40:08 INFO - Running pre-action listener: _resource_record_pre_action 09:40:08 INFO - Running main action method: create_virtualenv 09:40:08 INFO - Creating virtualenv /builds/slave/test/build/venv 09:40:08 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 09:40:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:40:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:40:08 INFO - Using real prefix '/tools/python27' 09:40:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:40:09 INFO - Installing distribute.............................................................................................................................................................................................done. 09:40:12 INFO - Installing pip.................done. 09:40:12 INFO - Return code: 0 09:40:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:40:12 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')]} 09:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:12 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')]} 09:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:12 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 0x1048cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde984a7b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104772d30>, '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 0x1045d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104769b20>, '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.53dtWUXQxF/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.LFyasPIJXH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 09:40:12 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 09:40:12 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 09:40:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.53dtWUXQxF/Render', 09:40:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:12 INFO - 'HOME': '/Users/cltbld', 09:40:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:12 INFO - 'LOGNAME': 'cltbld', 09:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:12 INFO - 'MOZ_NO_REMOTE': '1', 09:40:12 INFO - 'NO_EM_RESTART': '1', 09:40:12 INFO - 'PAGER': '/bin/cat', 09:40:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:12 INFO - 'PWD': '/builds/slave/test', 09:40:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:12 INFO - 'SHELL': '/bin/bash', 09:40:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LFyasPIJXH/Listeners', 09:40:12 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 09:40:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:12 INFO - 'USER': 'cltbld', 09:40:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:12 INFO - 'XPC_FLAGS': '0x0', 09:40:12 INFO - 'XPC_SERVICE_NAME': '0', 09:40:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:12 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 09:40:12 INFO - Cleaning up... 09:40:12 INFO - Return code: 0 09:40:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:40:12 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')]} 09:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:12 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')]} 09:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:12 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 0x1048cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde984a7b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104772d30>, '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 0x1045d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104769b20>, '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.53dtWUXQxF/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.LFyasPIJXH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 09:40:12 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 09:40:12 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 09:40:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.53dtWUXQxF/Render', 09:40:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:12 INFO - 'HOME': '/Users/cltbld', 09:40:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:12 INFO - 'LOGNAME': 'cltbld', 09:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:12 INFO - 'MOZ_NO_REMOTE': '1', 09:40:12 INFO - 'NO_EM_RESTART': '1', 09:40:12 INFO - 'PAGER': '/bin/cat', 09:40:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:12 INFO - 'PWD': '/builds/slave/test', 09:40:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:12 INFO - 'SHELL': '/bin/bash', 09:40:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LFyasPIJXH/Listeners', 09:40:12 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 09:40:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:12 INFO - 'USER': 'cltbld', 09:40:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:12 INFO - 'XPC_FLAGS': '0x0', 09:40:12 INFO - 'XPC_SERVICE_NAME': '0', 09:40:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:13 INFO - Downloading/unpacking psutil>=0.7.1 09:40:13 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 09:40:13 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 09:40:13 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 09:40:13 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 09:40:13 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 09:40:13 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 09:40:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:40:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:40:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:40:16 INFO - Installing collected packages: psutil 09:40:16 INFO - Running setup.py install for psutil 09:40:16 INFO - building 'psutil._psutil_osx' extension 09:40:16 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 09:40:16 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 09:40:16 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 09:40:17 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 09:40:17 INFO - building 'psutil._psutil_posix' extension 09:40:17 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 09:40:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:40:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:40:17 INFO - ^ 09:40:17 INFO - 1 warning generated. 09:40:17 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 09:40:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:40:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:40:17 INFO - Successfully installed psutil 09:40:17 INFO - Cleaning up... 09:40:17 INFO - Return code: 0 09:40:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1048cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde984a7b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104772d30>, '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 0x1045d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104769b20>, '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.53dtWUXQxF/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.LFyasPIJXH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 09:40:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:40:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:40:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.53dtWUXQxF/Render', 09:40:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:17 INFO - 'HOME': '/Users/cltbld', 09:40:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:17 INFO - 'LOGNAME': 'cltbld', 09:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:17 INFO - 'MOZ_NO_REMOTE': '1', 09:40:17 INFO - 'NO_EM_RESTART': '1', 09:40:17 INFO - 'PAGER': '/bin/cat', 09:40:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:17 INFO - 'PWD': '/builds/slave/test', 09:40:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:17 INFO - 'SHELL': '/bin/bash', 09:40:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LFyasPIJXH/Listeners', 09:40:17 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 09:40:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:17 INFO - 'USER': 'cltbld', 09:40:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:17 INFO - 'XPC_FLAGS': '0x0', 09:40:17 INFO - 'XPC_SERVICE_NAME': '0', 09:40:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:40:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:40:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:40:20 INFO - Installing collected packages: mozsystemmonitor 09:40:20 INFO - Running setup.py install for mozsystemmonitor 09:40:20 INFO - Successfully installed mozsystemmonitor 09:40:20 INFO - Cleaning up... 09:40:20 INFO - Return code: 0 09:40:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:40:20 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')]} 09:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:20 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')]} 09:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:20 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 0x1048cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde984a7b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104772d30>, '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 0x1045d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104769b20>, '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.53dtWUXQxF/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.LFyasPIJXH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 09:40:20 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 09:40:20 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 09:40:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.53dtWUXQxF/Render', 09:40:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:20 INFO - 'HOME': '/Users/cltbld', 09:40:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:20 INFO - 'LOGNAME': 'cltbld', 09:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:20 INFO - 'MOZ_NO_REMOTE': '1', 09:40:20 INFO - 'NO_EM_RESTART': '1', 09:40:20 INFO - 'PAGER': '/bin/cat', 09:40:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:20 INFO - 'PWD': '/builds/slave/test', 09:40:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:20 INFO - 'SHELL': '/bin/bash', 09:40:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LFyasPIJXH/Listeners', 09:40:20 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 09:40:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:20 INFO - 'USER': 'cltbld', 09:40:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:20 INFO - 'XPC_FLAGS': '0x0', 09:40:20 INFO - 'XPC_SERVICE_NAME': '0', 09:40:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:20 INFO - Downloading/unpacking blobuploader==1.2.4 09:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:23 INFO - Downloading blobuploader-1.2.4.tar.gz 09:40:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:40:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:40:23 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 09:40:23 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 09:40:23 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 09:40:23 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 09:40:23 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 09:40:23 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 09:40:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:40:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:40:23 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 09:40:23 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 09:40:23 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 09:40:23 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 09:40:23 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 09:40:23 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 09:40:24 INFO - Downloading docopt-0.6.1.tar.gz 09:40:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:40:24 INFO - Installing collected packages: blobuploader, requests, docopt 09:40:24 INFO - Running setup.py install for blobuploader 09:40:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:40:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:40:24 INFO - Running setup.py install for requests 09:40:25 INFO - Running setup.py install for docopt 09:40:25 INFO - Successfully installed blobuploader requests docopt 09:40:25 INFO - Cleaning up... 09:40:25 INFO - Return code: 0 09:40:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:25 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')]} 09:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:25 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')]} 09:40:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:25 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 0x1048cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde984a7b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104772d30>, '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 0x1045d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104769b20>, '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.53dtWUXQxF/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.LFyasPIJXH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 09:40:25 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 09:40:25 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 09:40:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.53dtWUXQxF/Render', 09:40:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:25 INFO - 'HOME': '/Users/cltbld', 09:40:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:25 INFO - 'LOGNAME': 'cltbld', 09:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:25 INFO - 'MOZ_NO_REMOTE': '1', 09:40:25 INFO - 'NO_EM_RESTART': '1', 09:40:25 INFO - 'PAGER': '/bin/cat', 09:40:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:25 INFO - 'PWD': '/builds/slave/test', 09:40:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:25 INFO - 'SHELL': '/bin/bash', 09:40:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LFyasPIJXH/Listeners', 09:40:25 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 09:40:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:25 INFO - 'USER': 'cltbld', 09:40:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:25 INFO - 'XPC_FLAGS': '0x0', 09:40:25 INFO - 'XPC_SERVICE_NAME': '0', 09:40:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:40:25 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-KhHSyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:40:25 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-jMwhBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:40:25 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-zvBNJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:40:25 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-gHGXFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:40:25 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-eaUXCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:40:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-J9X4t6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:40:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-DMkwVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:40:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-e5D9Y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:40:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-qGh7sY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:40:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-kCNv_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:40:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-o_zpD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:40:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-GCgTSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:40:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-3rswHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:40:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-3vXblT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-0EuS11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:40:27 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-RapkXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:40:27 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-gj_SuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:40:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:40:27 INFO - Running setup.py install for manifestparser 09:40:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:40:27 INFO - Running setup.py install for mozcrash 09:40:27 INFO - Running setup.py install for mozdebug 09:40:27 INFO - Running setup.py install for mozdevice 09:40:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:40:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:40:27 INFO - Running setup.py install for mozfile 09:40:28 INFO - Running setup.py install for mozhttpd 09:40:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:40:28 INFO - Running setup.py install for mozinfo 09:40:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:40:28 INFO - Running setup.py install for mozInstall 09:40:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:40:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:40:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:40:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:40:28 INFO - Running setup.py install for mozleak 09:40:28 INFO - Running setup.py install for mozlog 09:40:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:40:28 INFO - Running setup.py install for moznetwork 09:40:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:40:28 INFO - Running setup.py install for mozprocess 09:40:29 INFO - Running setup.py install for mozprofile 09:40:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:40:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:40:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:40:29 INFO - Running setup.py install for mozrunner 09:40:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:40:29 INFO - Running setup.py install for mozscreenshot 09:40:29 INFO - Running setup.py install for moztest 09:40:29 INFO - Running setup.py install for mozversion 09:40:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:40:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:40:29 INFO - Cleaning up... 09:40:29 INFO - Return code: 0 09:40:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40: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')]} 09:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40: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')]} 09:40:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:29 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 0x1048cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde984a7b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104772d30>, '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 0x1045d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104769b20>, '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.53dtWUXQxF/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.LFyasPIJXH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 09:40:29 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 09:40:29 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 09:40:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.53dtWUXQxF/Render', 09:40:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:29 INFO - 'HOME': '/Users/cltbld', 09:40:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:29 INFO - 'LOGNAME': 'cltbld', 09:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:29 INFO - 'MOZ_NO_REMOTE': '1', 09:40:29 INFO - 'NO_EM_RESTART': '1', 09:40:29 INFO - 'PAGER': '/bin/cat', 09:40:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:29 INFO - 'PWD': '/builds/slave/test', 09:40:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:29 INFO - 'SHELL': '/bin/bash', 09:40:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LFyasPIJXH/Listeners', 09:40:29 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 09:40:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:29 INFO - 'USER': 'cltbld', 09:40:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:29 INFO - 'XPC_FLAGS': '0x0', 09:40:29 INFO - 'XPC_SERVICE_NAME': '0', 09:40:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:40:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-jb5nsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:40:30 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)) 09:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:40:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-luAm2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:40:30 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)) 09:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:40:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-latfW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:40:30 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)) 09:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:40:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-mCwVUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:40:30 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)) 09:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:40:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-kfPzlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:40:30 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)) 09:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:40:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-k6xmsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:40:30 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)) 09:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:40:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-5YCONH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:40:30 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)) 09:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:40:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-mRyBU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:40:30 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)) 09:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:40:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-PLoex2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:40:31 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)) 09:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:40:31 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Q4KFM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:40:31 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)) 09:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:40:31 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-adR3FH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:40:31 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)) 09:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:40:31 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-rS5zRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:40:31 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)) 09:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:40:31 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-X_Bkz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:40:31 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)) 09:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:40:31 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-DjIBXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:40:31 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)) 09:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:31 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-4AODfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:31 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)) 09:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:40:31 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-SFCCpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:40:31 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)) 09:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:40:31 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-RFqMI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:40:31 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)) 09:40:31 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)) 09:40:31 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)) 09:40:31 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)) 09:40:31 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)) 09:40:31 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)) 09:40:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:40:31 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 09:40:31 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 09:40:31 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 09:40:31 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 09:40:31 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 09:40:31 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 09:40:34 INFO - Downloading blessings-1.6.tar.gz 09:40:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:40:34 INFO - Installing collected packages: blessings 09:40:34 INFO - Running setup.py install for blessings 09:40:34 INFO - Successfully installed blessings 09:40:34 INFO - Cleaning up... 09:40:34 INFO - Return code: 0 09:40:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:40:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:40:34 INFO - Reading from file tmpfile_stdout 09:40:34 INFO - Current package versions: 09:40:34 INFO - blessings == 1.6 09:40:34 INFO - blobuploader == 1.2.4 09:40:34 INFO - docopt == 0.6.1 09:40:34 INFO - manifestparser == 1.1 09:40:34 INFO - mozInstall == 1.12 09:40:34 INFO - mozcrash == 0.17 09:40:34 INFO - mozdebug == 0.1 09:40:34 INFO - mozdevice == 0.48 09:40:34 INFO - mozfile == 1.2 09:40:34 INFO - mozhttpd == 0.7 09:40:34 INFO - mozinfo == 0.9 09:40:34 INFO - mozleak == 0.1 09:40:34 INFO - mozlog == 3.1 09:40:34 INFO - moznetwork == 0.27 09:40:34 INFO - mozprocess == 0.22 09:40:34 INFO - mozprofile == 0.28 09:40:34 INFO - mozrunner == 6.11 09:40:34 INFO - mozscreenshot == 0.1 09:40:34 INFO - mozsystemmonitor == 0.0 09:40:34 INFO - moztest == 0.7 09:40:34 INFO - mozversion == 1.4 09:40:34 INFO - psutil == 3.1.1 09:40:34 INFO - requests == 1.2.3 09:40:34 INFO - wsgiref == 0.1.2 09:40:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:40:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:34 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 0x1048cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde984a7b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104772d30>, '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 0x1045d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104769b20>, '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.53dtWUXQxF/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.LFyasPIJXH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 09:40:34 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 09:40:34 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 09:40:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.53dtWUXQxF/Render', 09:40:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:34 INFO - 'HOME': '/Users/cltbld', 09:40:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:34 INFO - 'LOGNAME': 'cltbld', 09:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:34 INFO - 'MOZ_NO_REMOTE': '1', 09:40:34 INFO - 'NO_EM_RESTART': '1', 09:40:34 INFO - 'PAGER': '/bin/cat', 09:40:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:34 INFO - 'PWD': '/builds/slave/test', 09:40:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:34 INFO - 'SHELL': '/bin/bash', 09:40:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LFyasPIJXH/Listeners', 09:40:34 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 09:40:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:34 INFO - 'USER': 'cltbld', 09:40:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:34 INFO - 'XPC_FLAGS': '0x0', 09:40:34 INFO - 'XPC_SERVICE_NAME': '0', 09:40:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:35 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)) 09:40:35 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)) 09:40:35 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)) 09:40:35 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)) 09:40:35 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)) 09:40:35 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)) 09:40:35 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)) 09:40:35 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)) 09:40:35 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)) 09:40:35 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)) 09:40:35 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)) 09:40:35 INFO - Cleaning up... 09:40:35 INFO - Return code: 0 09:40:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:40:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:35 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 0x1048cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde984a7b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104772d30>, '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 0x1045d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104769b20>, '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.53dtWUXQxF/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.LFyasPIJXH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 09:40:35 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 09:40:35 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 09:40:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.53dtWUXQxF/Render', 09:40:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:35 INFO - 'HOME': '/Users/cltbld', 09:40:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:35 INFO - 'LOGNAME': 'cltbld', 09:40:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:35 INFO - 'MOZ_NO_REMOTE': '1', 09:40:35 INFO - 'NO_EM_RESTART': '1', 09:40:35 INFO - 'PAGER': '/bin/cat', 09:40:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:35 INFO - 'PWD': '/builds/slave/test', 09:40:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:35 INFO - 'SHELL': '/bin/bash', 09:40:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LFyasPIJXH/Listeners', 09:40:35 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 09:40:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:35 INFO - 'USER': 'cltbld', 09:40:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:35 INFO - 'XPC_FLAGS': '0x0', 09:40:35 INFO - 'XPC_SERVICE_NAME': '0', 09:40:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:35 INFO - Downloading/unpacking jsonschema 09:40: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 09:40: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 09:40: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 09:40: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 09:40: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 09:40: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 09:40:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:40:37 INFO - Downloading/unpacking functools32 (from jsonschema) 09:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:38 INFO - Downloading functools32-3.2.3-2.tar.gz 09:40:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:40:38 INFO - warning: no files found matching '*.txt' 09:40:38 INFO - no previously-included directories found matching 'build' 09:40:38 INFO - no previously-included directories found matching 'dist' 09:40:38 INFO - no previously-included directories found matching '.git*' 09:40:38 INFO - Installing collected packages: jsonschema, functools32 09:40:38 INFO - Running setup.py install for functools32 09:40:38 INFO - warning: no files found matching '*.txt' 09:40:38 INFO - no previously-included directories found matching 'build' 09:40:38 INFO - no previously-included directories found matching 'dist' 09:40:38 INFO - no previously-included directories found matching '.git*' 09:40:38 INFO - Successfully installed jsonschema functools32 09:40:38 INFO - Cleaning up... 09:40:38 INFO - Return code: 0 09:40:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:40:38 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')]} 09:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:38 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')]} 09:40:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:38 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 0x1048cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048d54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde984a7b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104772d30>, '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 0x1045d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104769b20>, '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.53dtWUXQxF/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.LFyasPIJXH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 09:40:38 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 09:40:38 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 09:40:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.53dtWUXQxF/Render', 09:40:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:38 INFO - 'HOME': '/Users/cltbld', 09:40:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:38 INFO - 'LOGNAME': 'cltbld', 09:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:38 INFO - 'MOZ_NO_REMOTE': '1', 09:40:38 INFO - 'NO_EM_RESTART': '1', 09:40:38 INFO - 'PAGER': '/bin/cat', 09:40:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:38 INFO - 'PWD': '/builds/slave/test', 09:40:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:38 INFO - 'SHELL': '/bin/bash', 09:40:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LFyasPIJXH/Listeners', 09:40:38 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 09:40:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:38 INFO - 'USER': 'cltbld', 09:40:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:38 INFO - 'XPC_FLAGS': '0x0', 09:40:38 INFO - 'XPC_SERVICE_NAME': '0', 09:40:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:38 INFO - Downloading/unpacking flake8 09:40:38 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 09:40:38 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 09:40:38 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 09:40:38 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 09:40:38 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 09:40:38 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 09:40:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:40:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:40:41 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 09:40:41 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 09:40:41 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 09:40:41 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 09:40:41 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 09:40:41 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 09:40:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:40:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:40:41 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 09:40:41 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 09:40:41 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 09:40:41 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 09:40:41 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 09:40:41 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 09:40:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:40:41 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 09:40:41 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 09:40:41 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 09:40:41 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 09:40:41 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 09:40:41 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 09:40:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:40:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:40:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:40:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:40:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:40:42 INFO - no previously-included directories found matching 'docs/_build' 09:40:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:40:42 INFO - Running setup.py install for pep8 09:40:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:40:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:40:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:40:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:40:42 INFO - no previously-included directories found matching 'docs/_build' 09:40:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:40:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:40:42 INFO - Cleaning up... 09:40:42 INFO - Return code: 0 09:40:42 INFO - Running post-action listener: _resource_record_post_action 09:40:42 INFO - Running post-action listener: _start_resource_monitoring 09:40:42 INFO - Starting resource monitoring. 09:40:42 INFO - ##### 09:40:42 INFO - ##### Running install step. 09:40:42 INFO - ##### 09:40:42 INFO - Running pre-action listener: _resource_record_pre_action 09:40:42 INFO - Running main action method: install 09:40:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:40:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:40:43 INFO - Reading from file tmpfile_stdout 09:40:43 INFO - Detecting whether we're running mozinstall >=1.0... 09:40:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:40:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:40:43 INFO - Reading from file tmpfile_stdout 09:40:43 INFO - Output received: 09:40:43 INFO - Usage: mozinstall [options] installer 09:40:43 INFO - Options: 09:40:43 INFO - -h, --help show this help message and exit 09:40:43 INFO - -d DEST, --destination=DEST 09:40:43 INFO - Directory to install application into. [default: 09:40:43 INFO - "/builds/slave/test"] 09:40:43 INFO - --app=APP Application being installed. [default: firefox] 09:40:43 INFO - mkdir: /builds/slave/test/build/application 09:40:43 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'] 09:40:43 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 09:41:14 INFO - Reading from file tmpfile_stdout 09:41:14 INFO - Output received: 09:41:14 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:41:14 INFO - Running post-action listener: _resource_record_post_action 09:41:14 INFO - ##### 09:41:14 INFO - ##### Running run-tests step. 09:41:14 INFO - ##### 09:41:14 INFO - Running pre-action listener: _resource_record_pre_action 09:41:14 INFO - Running main action method: run_tests 09:41:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:41:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:41:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:41:14 INFO - 2016-03-24 09:41:14.970 screenresolution[1644:7629] starting screenresolution argv=screenresolution get 09:41:14 INFO - 2016-03-24 09:41:14.972 screenresolution[1644:7629] Display 0: 1600x1200x32@60 09:41:14 INFO - 2016-03-24 09:41:14.978 screenresolution[1645:7631] starting screenresolution argv=screenresolution list 09:41:14 INFO - Available Modes on Display 0 09:41:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:41:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:41:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:41:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:41:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:41:15 INFO - Intel Iris: 09:41:15 INFO - Chipset Model: Intel Iris 09:41:15 INFO - Type: GPU 09:41:15 INFO - Bus: Built-In 09:41:15 INFO - VRAM (Dynamic, Max): 1536 MB 09:41:15 INFO - Vendor: Intel (0x8086) 09:41:15 INFO - Device ID: 0x0a2e 09:41:15 INFO - Revision ID: 0x0009 09:41:15 INFO - Displays: 09:41:15 INFO - Display: 09:41:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:41:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:41:15 INFO - Display Serial Number: 1600x1200 60 09:41:15 INFO - Main Display: Yes 09:41:15 INFO - Mirror: Off 09:41:15 INFO - Online: Yes 09:41:15 INFO - Rotation: Supported 09:41:15 INFO - Return code: 0 09:41:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:41:15 INFO - Python 2.7.3 09:41:15 INFO - Return code: 0 09:41:15 INFO - grabbing minidump binary from tooltool 09:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:41:15 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 0x104772d30>, '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 0x1045d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104769b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:41:15 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 09:41:15 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 09:41:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:41:15 INFO - Return code: 0 09:41:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:41:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:41:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:41:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:41:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:41:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:41:16 INFO - Return code: 0 09:41:16 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/X4gfkRzVQy-yftBSNYiC1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--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 09:41:16 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/X4gfkRzVQy-yftBSNYiC1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0111 --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 09:41:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.53dtWUXQxF/Render', 09:41:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:16 INFO - 'HOME': '/Users/cltbld', 09:41:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:16 INFO - 'LOGNAME': 'cltbld', 09:41:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:41:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:16 INFO - 'MOZ_NO_REMOTE': '1', 09:41:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:41:16 INFO - 'NO_EM_RESTART': '1', 09:41:16 INFO - 'PAGER': '/bin/cat', 09:41:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:16 INFO - 'PWD': '/builds/slave/test', 09:41:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:41:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:16 INFO - 'SHELL': '/bin/bash', 09:41:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LFyasPIJXH/Listeners', 09:41:16 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 09:41:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:16 INFO - 'USER': 'cltbld', 09:41:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:16 INFO - 'XPC_FLAGS': '0x0', 09:41:16 INFO - 'XPC_SERVICE_NAME': '0', 09:41:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:16 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/X4gfkRzVQy-yftBSNYiC1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--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 09:41:16 INFO - mozversion application_buildid: 20160324073337 09:41:16 INFO - mozversion application_changeset: 54836a65a622ddbefa6dd19b1a33168f392dab72 09:41:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:41:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:41:16 INFO - mozversion application_name: Firefox 09:41:16 INFO - mozversion application_remotingname: firefox-dev 09:41:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:41:16 INFO - mozversion application_vendor: Mozilla 09:41:16 INFO - mozversion application_version: 47.0a2 09:41:16 INFO - mozversion platform_buildid: 20160324073337 09:41:16 INFO - mozversion platform_changeset: 54836a65a622ddbefa6dd19b1a33168f392dab72 09:41:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:41:16 INFO - mozversion platform_version: 47.0a2 09:41:16 INFO - using testdate: 1458837676 09:41:16 INFO - actual date: 1458837676 09:41:16 INFO - starting webserver on 'localhost:49280' 09:41:16 INFO - SUITE-START | Running 2 tests 09:41:16 INFO - TEST-START | dromaeo_css 09:41:16 INFO - operating with platform_type : mac_ 09:41:16 INFO - Initialising browser for dromaeo_css test... 09:41:16 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpIhPqTh/profile http://localhost:49280/getInfo.html) 09:41:19 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 09:41:19 INFO - PROCESS | 1663 | colorDepth:24 09:41:19 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 09:41:19 INFO - PROCESS | 1663 | __metrics 09:41:19 INFO - PROCESS | 1663 | 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" 09:41:19 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:41:19 INFO - TEST-INFO | 1663: exit 0 09:41:19 INFO - Browser initialized. 09:41:19 INFO - Running cycle 1/1 for dromaeo_css test... 09:41:19 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpIhPqTh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:41:31 INFO - PROCESS | 1665 | RSS: Main: 210644992 09:41:31 INFO - PROCESS | 1665 | 09:42:23 INFO - PROCESS | 1665 | 1458837743280 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] 09:44:33 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 09:44:35 INFO - PROCESS | 1665 | RSS: Main: 350158848 09:44:35 INFO - PROCESS | 1665 | 09:47:37 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 09:47:38 INFO - PROCESS | 1665 | RSS: Main: 349167616 09:47:38 INFO - PROCESS | 1665 | 09:50:40 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 09:50:40 INFO - PROCESS | 1665 | RSS: Main: 348844032 09:50:40 INFO - PROCESS | 1665 | 09:53:42 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 09:53:43 INFO - PROCESS | 1665 | RSS: Main: 313520128 09:53:43 INFO - PROCESS | 1665 | 09:56:46 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 09:56:47 INFO - PROCESS | 1665 | RSS: Main: 313704448 09:56:47 INFO - PROCESS | 1665 | 09:59:49 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 09:59:50 INFO - PROCESS | 1665 | RSS: Main: 360910848 09:59:50 INFO - PROCESS | 1665 | 09:59:50 INFO - PROCESS | 1665 | __start_tp_report 09:59:50 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 09:59:50 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 09:59:50 INFO - PROCESS | 1665 | |i|pagename|runs| 09:59:50 INFO - PROCESS | 1665 | |0;dojo.html;3456.2223499712554;3480.443129099345;3509.66658167474;3511.6137224905256;3552.3960926642467;5869.471747542721;5872.295324561053;5884.4409781070835;5913.970430147849;5936.851578710534;5853.7365818538165;5887.8233652990375;5903.4686878180955;5903.586748927577;5919.792807251747;5189.922151167735;5238.240455134013;5242.55438287746;5259.579233661298;5306.495882891119;5274.208868669711;5276;5276.419593844674;5277.234800953878;5278.524932756051;5266.8683282917855;5268.894622107556;5314.92027619586;5319.574434045287;5350.5452036576935;5326.786928522854;5343.973280133613;5366.517013468787;5366.597505187126;5389.595780316453;5077.111505486525;5281.339832520935;5296.947030529684;5301.0723123453245;5305.257263983045;5778.075507918713;5790.652560846321;5848.619839710405;5850.268716410449;5868.911966320508;6230.657313847737;6306.306306306303;6309.305976342599;6329.620222786648;6340.651264180515;6239.594426362272;6260;6290.716917738713;6313.179286692746;6340;5986;6009.819705408801;6018.368071352533;6019.036954087325;6032.758689652364;6211.875762484725;6292.244930608356;6371.904421433682;6388.201474815648;6388.776392826322;6307.148534947815;6307.24313082433;6312.6212427253595;6324.33594472583;6324.9051264231075;6290.087937249074;6296.590721603081;6301.7164227609865;6317.589356691892;6322.683865806784;5316.175992721134;6149.831532008904;6267.843303917347;6283.497320214372;6365.3316401778075;6281.277653069956;6298.779542715983;6301.338359472281;6309.652969086745;6326.145970294044;4331.696781225347;4889.217725164028;4974.9751251243515;4975.651704380731;4993.400791904995;4401.977990110029;4510.909781804346;4525.570070843265;4550.089982003613;4558.361829343895;5709.42905709434;5769.134629805562;5780.710964451845;5783.913241301384;5784.479396854219;5151.716655583904;6072.724727807122;6181.938180618136;6335.11308416822;6339.397757213057;5209.088409528317;5776.595638305363;5846.649201047951;5848.912266316009;5852.678102704307;5344.839654810362;5445.264889239981;5450.754716037788;5451.3458384994055;5480.588955828249;6314.55798094129;6336.334684858116;6392.904106438407;6480.222373315044;6529.053287273224;6283.622982621057;6311.400416960381;6311.715972781328;6312.147860038836;6318.84202894913;6292.559520833498;6421.293657697556;6471.191101112361;6483.351664833479;6486.772962946275;6223.3465486123305;6268.811935641938;6296.905546416716;6301.6219026858535;6312.905306420499;5331.280277162688;6233.314335423009;6279.120923070683;6288.465480434032;6320.336364681642;5966.701664916824;6161.568690191643;6258.4680302173;6262.09199666055;6287.497000239879;6157.84605384869;6225.035119556476;6231.906521402273;6232.968835155795;6241.812745617639;5805.970970145122;6058.3335833057445;6083;6083.908741368795;6085;6064.241969753781;6169.876602468015;6175.972927241891;6178.258608966953;6243.937560624518;5334.573234141182;6084.178635884099;6115.635867915819;6145.66198859067;6173.135760993375 09:59:50 INFO - PROCESS | 1665 | |1;ext.html;498.8750367920339;566.73363519146;578.884223155369;588.2822955993686;650.8242774450898;27531.862340688294;40547.18905621886;40883.99999999996;41083.97290067742;41177.382339264936;44533.886652833695;44869.32696009563;44921.775391122996;44947.72996565321;45202.77398613011;9800;10030;10035.749106272366;10039.09648131668;10045.748856278578;9712.465814380206;9810.656627018056;9826.263030272723;9828.557714902847;9938.9503052485;9920.00799920006;9945.15466185375;9957.45234012129;9962.750931226705;9978.251631127694;9871.753206169868;9935.950320248425;9950.900490995069;9952.800943981152;9955;8541.35939804511;9753.366031207948;9916.752081197956;9919.603215871357;9924.603015879356;43306.78346608279;43635.563644363465;43649;43713;43726.344104838136;3266.8039917604783;3347.7321814255047;3365.6297807241185;3374.3926093303194;3402.795832250073;29873.95441159549;30163.245918851986;30297.545536816964;30414.54378184329;30543.69456305431;2727.618133461317;2781.3880946191807;2810.283377738684;2840.8011439199263;2846.6299381080535;370616;370645;371240;371456.9999999973;371794;72041.27958720451;72274.2772572278;72309.27690723025;72387.6380618104;72608.27391726016;75808;76150.85773713399;79863;81253.59373203096;81365.59317203375;18689.532761680795;18727.438176854717;18936.62126757457;18960.620787584172;18965.241390344232;14123.71752564943;14294.571162865132;14305.427782888568;14307.92846035763;14333.426662933574;18371.540711482052;23432.64851027236;23456.76543234546;23532.176373826835;23917.80410979444;8033.192531680442;9828.149836547464;9832.01679832011;9835.704928852147;9842.852357214648;947.6304241345881;1045.13253999182;1064.2124827627654;1127.2729089737074;1135.4379830329963;30581.847090764848;30669;30997.845010774803;31338;31487.685123148476;940.6989763275686;1163.5055101581793;1198.6583823610404;1200.327816422806;1217.452146534063;15753.369865205492;16270.918645406933;16276.43032493857;16387.672246555;16928.661426771396;517847;521805;527166.7283327117;534151;534548;62410.0638490423;62982.685086574274;63009.05486417707;63016;63157.68421157865;1379.717157982611;1413.9010269281257;1529.05962832857;1560.2120928931045;1627.584965833705;28908.566371504025;29639.851800740857;29824;30298.939537116094;30407.239819004702;48348;48714.756426217646;48826.511734882195;48933.51066489289;48959;323350;325131;325420;326195;326531;35033.64966350304;47709.28436073531;49046.019079617494;49759;50534.241986369496;47219.763901180275;47361.28958065701;48119.278210827564;48903;48944.28694995658;37830.24339513249;39253.03734813305;39263.6257730978;39379.40930885982;39569.406458903715;38598.42102368523;38744;38804.41793373158;39538.40692389559;39986.80006600065;41056.1788764229;41518.1696366077;41590.792046039576;41928;42011.579884200764;33376.66623333735;34436.31127377489;35156.64843351636;35179.824100879334;35702.46446303256;25809;27046.72953270521;27097.885560373703;27109.86445067762;27126.1862144136 09:59:50 INFO - PROCESS | 1665 | |2;jquery.html;372.85831384074055;378.63650895140665;379.11476701901057;379.2528718424704;386.35478750486686;20600;20622;20712;21474.463138421546;21554.245601403934;12489.500419983213;14818.110913345206;19781.307654232103;20302;20303.984800759976;4246.532881383061;5298.655587386817;5534.833954981357;5540.058190107691;5717.456841600041;4109.28087584673;4307.763073030982;4349.782510874444;6185.288691800455;6186.938130618703;6170.413810687977;6172.47533959614;6173.074038894157;6173.382661733813;6177.351378105302;5632.493075623193;5936.910946335808;5938.198343223696;5943.494802941756;5958.314793798703;3999.320115580358;7134.857302853966;7447.404207663374;7450.366718828906;7465.6267186641;26505.072322468815;26678.33304167392;27434.862825685945;28018.439631207464;28042.85978570094;2331.6852224949585;2496.3259919821726;2535.809814263919;2621;3161.9051428457183;14773.556793296219;15763.605909852231;15772.447964321194;15807.051576905422;15933.681326373524;1850.565117197471;1885.4155211884222;1953.9413817585496;1961.686130219158;1970.4876732049627;100995;108756.4562177184;110747.44626276898;113122.43438782835;113318.43340783326;19447.124879380463;20115.698264526043;20289.188432462535;20319.288824891057;20324.898375508026;29823.10530684083;29839.85080074586;30196.849015754782;30374.025688330188;30447.695523044928;11169;11436.256643318158;11464.25482343645;11516.769664606662;11621.954024137869;8434.831303374021;9360.344775865624;9671.661491847752;9707.514624268759;9835.655752048644;8753.649854005896;8940.73177804667;8964.8655270171;9018.053104423941;9048.049954754788;2974.4051189761703;3566.4472006838982;3653.214558869856;3701.5002974598624;3714.888553343404;925.153484561632;975.5073687787622;993.8062077894741;1002.2032484175098;1043.8173319669027;19308.227670893288;19731.309404170785;20110.69833952492;20218.191272349235;20731.585368292548;1000.474750755859;1003.7239759066169;1014.9847752283722;1070.71626019105;1120.9775804484027;10406.219533535015;10829;10868.021878031015;10894.346339219672;11028.944855275673;441158;549502;550078;550370;626902;119142.40428797973;122670;126149;132246;138312.30843845717;466.37039996005797;485.44174199669953;485.5993805110798;488.21884984025274;489.1562055454384;11137;11184.440777960906;11481.483333250191;11755.588554400554;11933.045356371296;48850.022999540524;50583;52476.21285680794;52773.7361313191;53151;61045.47386315378;71543.64228178826;75360;76835;78452.60773696096;6880.827979300558;8063.435559511013;8179.591020448835;8221.424500284922;8577.356698247531;8552.786180345542;11725;13138;13613.11514751538;13669.726605467637;9707.466089365153;11438.771224575295;11681.299122052704;12037.518499259932;12122.575709850113;11300.547978081113;11322.773544529227;11380.487878045342;11464;11653.475593598478;10611.363318200933;10814.188935829687;11852.585159519376;12130.757384852077;12202.572909948465;8313;8342.29090527312;8497.957510212409;8577.699780507652;8690.91309086901;8919.375643705138;9727.464989425649;11662.650120496399;11765.352905590275;11906.345151016778 09:59:50 INFO - PROCESS | 1665 | |3;mootools.html;1443.549233020814;1624.1392062207028;1651.4385109062916;1982.7125066865306;2064.2259152817683;7547.698092076317;8804.691835785748;8890.288776897849;8890.466572005676;8892.377533572653;8383.958080209606;8602.827943441127;8607.225349718525;8625.266852317545;8632.697855575056;2259.3222033389998;2468.123816045305;2491.377155711072;2514.1326242446326;2523.785478234343;2564.6153077038407;2564.9358766030814;2567.4993376291536;2575.2403041102825;2576.1498705427257;2439.817013723969;2501.3621526510715;2504;2505.3736565858535;2508.636247744076;2471.6045432730766;2511.3344963584664;2565.2688983639573;2567.281161274846;2571.0101610879947;2507.2979565721625;2542.5423423783714;2546.987265063681;2570.4088059746177;2574.292069680834;9092.8636070459;9174.266058715286;9191.770205744842;9207.631694732203;9322.673706420243;5526.972365138148;5635.267415236034;5673.886522269573;5693.943060569424;5698.886022279573;3437.3984552703428;3528.4883691864793;3728.5712143103347;3731.197792474604;3744.8876533704033;1039.5270152080861;1062.4475272858149;1069.764651776608;1082.2856914436434;1109.362116782845;10623.52194151265;11910.821337680029;12277.57028504007;12308.015358771278;12331.445084971198;4943.9258411123865;5008.749562521859;5097.209932460474;5100.69395836251;5102.872428189325;10431.321964072311;10480.895191047992;10483.318584292148;10507.317024393544;10512.63205787809;4764.952350476451;5625.09998400254;5628.915566266509;5629.887402251932;5635.154726791015;4469.575390337913;4603.677742558056;4901.754912254373;4978.950210497921;5007.974960125176;3528.523649307362;4057.5542402426677;4098.918021639551;4152.480939882515;4197.370394440858;1298.480607756886;1374.896882733799;1375.4910683047137;1386.0990356268505;1388;1399.237415608496;1409.1685905315912;1452.3319273134266;1453.5276035288573;1460.4231328625133;8188.303994160444;8393.958030209931;8413.957930210432;8424.326053915673;8425.747227583182;521.9164933610604;527.7704198673589;527.862755683525;530.482779290189;545.4572700163284;6311.084892690534;6365.49076073913;6412.583182093149;6451.903221451682;6452.741890324428;10517.789644207072;10942.890571094187;10999.120070394349;11028.944855275833;11032.28290161137;10400.115990140923;10767.246292759432;10802.297850639683;10837.133029357632;10854;8497.44766590182;8506;8553.74338769838;8568.443051201652;8593;7871.370290376871;7949.125596184531;8013.278804907353;8064.596770161351;8101.108878023295;9481.905180948102;9759.46322952216;9786.168175705145;9889.851652225367;9949.403035817873;9801.754956126153;10085.949570252102;10237.641682541076;10302.587896484056;10310.742231444274;7665.3101220890385;7685.615719214129;7733.265339792711;7775.805604859697;7790.493617914817;8405.285550728257;8435.493870367798;8488.787780305542;8501.829963400822;8503.404761666625;7430.665620047219;7556.319931206218;7643;7659.961700191463;7761.534307941316;7385.926140738524;7518.624068796429;7529.435292352986;7645.847083058419;7682.462227644011;6986.580805151707;7781.299683028555;7979.9202007979175;8006.119326874155;8007.279344858757;7212.675429605785;7231.385332246818;7274.927250727636;7291.34377905991;7306.6711997959155;7322.926770732224;7354.77935661931;7413.925860741324;7416.888746668912;7417 09:59:50 INFO - PROCESS | 1665 | |4;prototype.html;332.53352714528927;335.4465132531325;336.63138862945067;342.11051266706556;347.16679968076613;6588.407043366096;6590.835229119274;6608.702608382617;6646.302138275484;6648.900266496001;5441.8572099859075;6524.934750652492;6535.281119076898;6538.934610653892;6568.80293591193;4048.2915489789316;4358.866694659396;4690.226112691402;4711.340412342275;4760.881192919661;4682.41469816273;4701.882452938669;4714.787834547454;4722.787474563635;4808.975955120237;4723.362346083286;4738.763061846911;4739.218029025206;4751.216049351853;4758.6668933174515;4291.605228300799;4334.848280310174;4749.0027094310235;4780.95219047812;4791.634384200521;3314.3371325734947;3899.883003509871;3997.120633460663;4007.358822588401;4118.155778065489;6078.483328917047;6303.086052522404;6351.872962540723;6364.395382438707;6366.490680745529;4670.976645116787;5608.355039170507;5647.632903861277;5661.433856614347;5668;7031.085958825372;7031.226565077837;7033.824154396129;7039.894401583981;7050.400715939151;4624.722516648978;4641.9535804641855;4648.418947631546;4669.929951050737;4672.766361681903;5965.970170149165;7122.821929451753;7418.554886706869;7423.109226892753;7430.14553326369;4737.739424331626;4754.762261886892;4757.167495688241;4761.523847615211;4769.332293478916;4834.178189707758;4839.104765618372;4844.224924012141;4848.175810112219;4865.318855360252;4605.194091034055;5658.321001479849;5662.235598194274;5674.574406919498;5683.8863222736145;6391.201099862517;6688.498362622823;7009.474289428314;7031.191412987469;7050.365467107882;1553.3631211203353;1628.6009927567823;1629.714799910011;1629.8451647093507;1633.8447847454472;883.7260449260622;1019.4036488654073;1031.6492392586556;1035.89123142069;1045.362328979322;6417.711202995783;6468.773592924225;6472.611643301417;6475.190601174853;6480.643564603898;6967.512274140761;7092.716291348392;7222.422206223489;7254.020707204565;7256.346928776436;6322.747090116436;6406.391392817675;6527.608343499405;6534.477241820643;6539.117219175446;3825.3114439401174;3880.320943834874;3884.0484081400236;3890.105275786585;3894.805259737002;7660.80847978805;7662.1571627120975;7680.078390593053;7682.692692292358;7689.231076892266;7269.563826170447;7551.5846628434865;7551.924480755232;7586.734464293723;7592.0130383050955;7594.848103037908;7601.315881570575;7614.428917831296;7633.160352361236;7635.007449031701;5891.911621325769;7279.59962202084;7283.781486555412;7295.781126566211;7315.646605378022;7164.176119746296;7172.924061390833;7177.677004534704;7178.605176715122;7181;7277.708891644275;7563.8109047272055;7642.770716878503;7643;7678.347340476123;4007.979960100181;4618.907621847611;4666.393368862026;4669.7431641260055;4684;5922.703864806828;7275.345218930322;7284.745033923788;7294.161171465137;7294.562326260441;7062.611556364449;7063.894041589483;7072.504924655224;7075.257098004841;7089.503734738519;6718.462522998051;7049.436045116481;7060.929390706027;7065.646717664199;7074.469414794014;6816.454683625199;6855.520113592001;6864.4165245954655;6866.931330686829;6869.244383117953;7046.753363632249;7065.258147894603;7067.8901283435125;7070;7084;6889.793306200822;6913.5506192097355;6920.9653951729915;6940.271271516418;6945.965270173819 09:59:50 INFO - PROCESS | 1665 | |5;yui.html;722.115408624435;728.7449392712555;768.5964868444066;785.4737325991581;818.6602559937626;15504.379824807009;15626;15656.452024179142;15661;17859.374921877738;16615;16644;16656.417025404113;16657.916710416463;16658.250378732955;795.7891158842912;965.5896244096249;977.2231076294328;979.9020097990215;981.906718861707;804.9758507244762;984.1831280037552;996.3324572536418;998.1515711645117;998.1765043838826;921.1709461484651;1041.0370407373186;1046.5865982936734;1048.0201012053753;1050.8633877595903;827.0323721246157;992.2756387836884;1034.8602938603267;1042.1662669864115;1043.8590790243334;767.6583920155533;771.8880762289492;775.577310365852;775.7556369743513;776.4409625069941;15553.533393998197;15642.452514162063;15643.061416315057;15656.765148522782;15672.294746736425;13121.950243980555;13213.471461141542;13305.40125694346;13320.533781317705;13494.797578036338;10219.335743176669;10312.484375781181;10407.843882341771;10668.199885008655;10698.358098514114;3504.6554749678107;3582.4268117101137;3586.1393265616325;3603.891883243507;3613.5483064616924;84546;87163;87516.56241718815;87842.5607871963;89595.55202224012;10058.497075146213;10146.340487868265;10292.382457052601;10292.897071029343;10698;23276.961077248066;23565.882170589037;23576.41058973505;23589.7641023591;24267.39331516726;7918.366530677532;8039.678412863537;8049.315808156255;8103.6758529658155;8181.222783835526;4189.287821070426;4223.704340696122;4240.3427468741775;4277.272863613193;4292.678049146327;3666.5416822897137;3716.349638813197;3717.498137751369;3718.4422336649177;3723.7765734056043;660.1088530483809;672.5661948043485;673.8685956238486;675.0144788608686;677.2719326723792;491.76395330241684;549.9367572729108;557.7133751618333;574.8332983434757;592.4283066840519;7989.600519973978;8042.03495580534;8191.344692424592;8267.8346433071;8326.12575679557;482.10088185534426;510.6629624447847;566.9546436285087;571.1261769492683;574.5145352177403;3285.589301337333;3697.8890633281044;3705.6850167735506;3748.493953316322;3803.5816060233906;89488.5525572381;90849.54575227082;91048.08951910528;97155;97948;73975.26024739792;75849.48301033948;76880.61559692166;77138;78417;68509.65745171341;68527.31472685309;69764.3023569768;69775.3022469779;70120.2987970124;7791.298783109547;8244.711435099982;8263.917360826315;8335.291500222549;8374.37192210599;49099.018019638694;50370.74073148201;52763;52966.735166323924;53375.46624533705;69089.61820763657;70315.59368812697;72720;76790.23209767831;76888.61555692185;10468.581256749645;10560.894391055992;10785.298955567863;10938;11124.944375278395;10051.949740251252;10070.899291007288;10457.790844182922;10554.419506926886;10599.576016959236;10786.676399708022;10856.728581785203;11043.337399756041;11146.164037697043;11301.604443844426;10656.360618362924;10879.945600271947;11294.774104517699;11334.433278335886;11370.374629395463;10917.890821091687;10932.617358392417;10988.120950324115;11038.613648522263;11702.476709386621;9030.593623286837;9252.49111298858;9307.11582399671;9456.101670341306;9474.431534107976;9053.456792592466;9511;9521.571529281338;9560.426374417557;9593.28050396209 09:59:50 INFO - PROCESS | 1665 | __end_tp_report 09:59:50 INFO - PROCESS | 1665 | __start_cc_report 09:59:50 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1232 09:59:50 INFO - PROCESS | 1665 | __end_cc_report 09:59:50 INFO - PROCESS | 1665 | __startTimestamp1458838790015__endTimestamp 09:59:50 INFO - PROCESS | 1665 | 09:59:50 INFO - PROCESS | 1665 | ------- Summary: start ------- 09:59:50 INFO - PROCESS | 1665 | Number of tests: 6 09:59:50 INFO - PROCESS | 1665 | 09:59:50 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5813.50 Median:6064.24 stddev:647.42 (10.7%) stddev-sans-first:622.44 09:59:50 INFO - PROCESS | 1665 | Values: 3456.2 3480.4 3509.7 3511.6 3552.4 5869.5 5872.3 5884.4 5914.0 5936.9 5853.7 5887.8 5903.5 5903.6 5919.8 5189.9 5238.2 5242.6 5259.6 5306.5 5274.2 5276.0 5276.4 5277.2 5278.5 5266.9 5268.9 5314.9 5319.6 5350.5 5326.8 5344.0 5366.5 5366.6 5389.6 5077.1 5281.3 5296.9 5301.1 5305.3 5778.1 5790.7 5848.6 5850.3 5868.9 6230.7 6306.3 6309.3 6329.6 6340.7 6239.6 6260.0 6290.7 6313.2 6340.0 5986.0 6009.8 6018.4 6019.0 6032.8 6211.9 6292.2 6371.9 6388.2 6388.8 6307.1 6307.2 6312.6 6324.3 6324.9 6290.1 6296.6 6301.7 6317.6 6322.7 5316.2 6149.8 6267.8 6283.5 6365.3 6281.3 6298.8 6301.3 6309.7 6326.1 4331.7 4889.2 4975.0 4975.7 4993.4 4402.0 4510.9 4525.6 4550.1 4558.4 5709.4 5769.1 5780.7 5783.9 5784.5 5151.7 6072.7 6181.9 6335.1 6339.4 5209.1 5776.6 5846.6 5848.9 5852.7 5344.8 5445.3 5450.8 5451.3 5480.6 6314.6 6336.3 6392.9 6480.2 6529.1 6283.6 6311.4 6311.7 6312.1 6318.8 6292.6 6421.3 6471.2 6483.4 6486.8 6223.3 6268.8 6296.9 6301.6 6312.9 5331.3 6233.3 6279.1 6288.5 6320.3 5966.7 6161.6 6258.5 6262.1 6287.5 6157.8 6225.0 6231.9 6233.0 6241.8 5806.0 6058.3 6083.0 6083.9 6085.0 6064.2 6169.9 6176.0 6178.3 6243.9 5334.6 6084.2 6115.6 6145.7 6173.1 09:59:50 INFO - PROCESS | 1665 | 09:59:50 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:58929.62 Median:39458.91 stddev:110305.48 (279.5%) stddev-sans-first:110527.67 09:59:50 INFO - PROCESS | 1665 | Values: 498.9 566.7 578.9 588.3 650.8 27531.9 40547.2 40884.0 41084.0 41177.4 44533.9 44869.3 44921.8 44947.7 45202.8 9800.0 10030.0 10035.7 10039.1 10045.7 9712.5 9810.7 9826.3 9828.6 9939.0 9920.0 9945.2 9957.5 9962.8 9978.3 9871.8 9936.0 9950.9 9952.8 9955.0 8541.4 9753.4 9916.8 9919.6 9924.6 43306.8 43635.6 43649.0 43713.0 43726.3 3266.8 3347.7 3365.6 3374.4 3402.8 29874.0 30163.2 30297.5 30414.5 30543.7 2727.6 2781.4 2810.3 2840.8 2846.6 370616.0 370645.0 371240.0 371457.0 371794.0 72041.3 72274.3 72309.3 72387.6 72608.3 75808.0 76150.9 79863.0 81253.6 81365.6 18689.5 18727.4 18936.6 18960.6 18965.2 14123.7 14294.6 14305.4 14307.9 14333.4 18371.5 23432.6 23456.8 23532.2 23917.8 8033.2 9828.1 9832.0 9835.7 9842.9 947.6 1045.1 1064.2 1127.3 1135.4 30581.8 30669.0 30997.8 31338.0 31487.7 940.7 1163.5 1198.7 1200.3 1217.5 15753.4 16270.9 16276.4 16387.7 16928.7 517847.0 521805.0 527166.7 534151.0 534548.0 62410.1 62982.7 63009.1 63016.0 63157.7 1379.7 1413.9 1529.1 1560.2 1627.6 28908.6 29639.9 29824.0 30298.9 30407.2 48348.0 48714.8 48826.5 48933.5 48959.0 323350.0 325131.0 325420.0 326195.0 326531.0 35033.6 47709.3 49046.0 49759.0 50534.2 47219.8 47361.3 48119.3 48903.0 48944.3 37830.2 39253.0 39263.6 39379.4 39569.4 38598.4 38744.0 38804.4 39538.4 39986.8 41056.2 41518.2 41590.8 41928.0 42011.6 33376.7 34436.3 35156.6 35179.8 35702.5 25809.0 27046.7 27097.9 27109.9 27126.2 09:59:50 INFO - PROCESS | 1665 | 09:59:50 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:33958.35 Median:28030.65 stddev:91363.28 (325.9%) stddev-sans-first:91584.78 09:59:50 INFO - PROCESS | 1665 | Values: 372.9 378.6 379.1 379.3 386.4 20600.0 20622.0 20712.0 21474.5 21554.2 12489.5 14818.1 19781.3 20302.0 20304.0 4246.5 5298.7 5534.8 5540.1 5717.5 4109.3 4307.8 4349.8 6185.3 6186.9 6170.4 6172.5 6173.1 6173.4 6177.4 5632.5 5936.9 5938.2 5943.5 5958.3 3999.3 7134.9 7447.4 7450.4 7465.6 26505.1 26678.3 27434.9 28018.4 28042.9 2331.7 2496.3 2535.8 2621.0 3161.9 14773.6 15763.6 15772.4 15807.1 15933.7 1850.6 1885.4 1953.9 1961.7 1970.5 100995.0 108756.5 110747.4 113122.4 113318.4 19447.1 20115.7 20289.2 20319.3 20324.9 29823.1 29839.9 30196.8 30374.0 30447.7 11169.0 11436.3 11464.3 11516.8 11622.0 8434.8 9360.3 9671.7 9707.5 9835.7 8753.6 8940.7 8964.9 9018.1 9048.0 2974.4 3566.4 3653.2 3701.5 3714.9 925.2 975.5 993.8 1002.2 1043.8 19308.2 19731.3 20110.7 20218.2 20731.6 1000.5 1003.7 1015.0 1070.7 1121.0 10406.2 10829.0 10868.0 10894.3 11028.9 441158.0 549502.0 550078.0 550370.0 626902.0 119142.4 122670.0 126149.0 132246.0 138312.3 466.4 485.4 485.6 488.2 489.2 11137.0 11184.4 11481.5 11755.6 11933.0 48850.0 50583.0 52476.2 52773.7 53151.0 61045.5 71543.6 75360.0 76835.0 78452.6 6880.8 8063.4 8179.6 8221.4 8577.4 8552.8 11725.0 13138.0 13613.1 13669.7 9707.5 11438.8 11681.3 12037.5 12122.6 11300.5 11322.8 11380.5 11464.0 11653.5 10611.4 10814.2 11852.6 12130.8 12202.6 8313.0 8342.3 8498.0 8577.7 8690.9 8919.4 9727.5 11662.7 11765.4 11906.3 09:59:50 INFO - PROCESS | 1665 | 09:59:50 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:6186.60 Median:524.84 stddev:3261.44 (621.4%) stddev-sans-first:3251.10 09:59:50 INFO - PROCESS | 1665 | Values: 1443.5 1624.1 1651.4 1982.7 2064.2 7547.7 8804.7 8890.3 8890.5 8892.4 8384.0 8602.8 8607.2 8625.3 8632.7 2259.3 2468.1 2491.4 2514.1 2523.8 2564.6 2564.9 2567.5 2575.2 2576.1 2439.8 2501.4 2504.0 2505.4 2508.6 2471.6 2511.3 2565.3 2567.3 2571.0 2507.3 2542.5 2547.0 2570.4 2574.3 9092.9 9174.3 9191.8 9207.6 9322.7 5527.0 5635.3 5673.9 5693.9 5698.9 3437.4 3528.5 3728.6 3731.2 3744.9 1039.5 1062.4 1069.8 1082.3 1109.4 10623.5 11910.8 12277.6 12308.0 12331.4 4943.9 5008.7 5097.2 5100.7 5102.9 10431.3 10480.9 10483.3 10507.3 10512.6 4765.0 5625.1 5628.9 5629.9 5635.2 4469.6 4603.7 4901.8 4979.0 5008.0 3528.5 4057.6 4098.9 4152.5 4197.4 1298.5 1374.9 1375.5 1386.1 1388.0 1399.2 1409.2 1452.3 1453.5 1460.4 8188.3 8394.0 8414.0 8424.3 8425.7 521.9 527.8 527.9 530.5 545.5 6311.1 6365.5 6412.6 6451.9 6452.7 10517.8 10942.9 10999.1 11028.9 11032.3 10400.1 10767.2 10802.3 10837.1 10854.0 8497.4 8506.0 8553.7 8568.4 8593.0 7871.4 7949.1 8013.3 8064.6 8101.1 9481.9 9759.5 9786.2 9889.9 9949.4 9801.8 10085.9 10237.6 10302.6 10310.7 7665.3 7685.6 7733.3 7775.8 7790.5 8405.3 8435.5 8488.8 8501.8 8503.4 7430.7 7556.3 7643.0 7660.0 7761.5 7385.9 7518.6 7529.4 7645.8 7682.5 6986.6 7781.3 7979.9 8006.1 8007.3 7212.7 7231.4 7274.9 7291.3 7306.7 7322.9 7354.8 7413.9 7416.9 7417.0 09:59:50 INFO - PROCESS | 1665 | 09:59:50 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:5713.89 Median:6502.79 stddev:1852.17 (28.5%) stddev-sans-first:1812.78 09:59:50 INFO - PROCESS | 1665 | Values: 332.5 335.4 336.6 342.1 347.2 6588.4 6590.8 6608.7 6646.3 6648.9 5441.9 6524.9 6535.3 6538.9 6568.8 4048.3 4358.9 4690.2 4711.3 4760.9 4682.4 4701.9 4714.8 4722.8 4809.0 4723.4 4738.8 4739.2 4751.2 4758.7 4291.6 4334.8 4749.0 4781.0 4791.6 3314.3 3899.9 3997.1 4007.4 4118.2 6078.5 6303.1 6351.9 6364.4 6366.5 4671.0 5608.4 5647.6 5661.4 5668.0 7031.1 7031.2 7033.8 7039.9 7050.4 4624.7 4642.0 4648.4 4669.9 4672.8 5966.0 7122.8 7418.6 7423.1 7430.1 4737.7 4754.8 4757.2 4761.5 4769.3 4834.2 4839.1 4844.2 4848.2 4865.3 4605.2 5658.3 5662.2 5674.6 5683.9 6391.2 6688.5 7009.5 7031.2 7050.4 1553.4 1628.6 1629.7 1629.8 1633.8 883.7 1019.4 1031.6 1035.9 1045.4 6417.7 6468.8 6472.6 6475.2 6480.6 6967.5 7092.7 7222.4 7254.0 7256.3 6322.7 6406.4 6527.6 6534.5 6539.1 3825.3 3880.3 3884.0 3890.1 3894.8 7660.8 7662.2 7680.1 7682.7 7689.2 7269.6 7551.6 7551.9 7586.7 7592.0 7594.8 7601.3 7614.4 7633.2 7635.0 5891.9 7279.6 7283.8 7295.8 7315.6 7164.2 7172.9 7177.7 7178.6 7181.0 7277.7 7563.8 7642.8 7643.0 7678.3 4008.0 4618.9 4666.4 4669.7 4684.0 5922.7 7275.3 7284.7 7294.2 7294.6 7062.6 7063.9 7072.5 7075.3 7089.5 6718.5 7049.4 7060.9 7065.6 7074.5 6816.5 6855.5 6864.4 6866.9 6869.2 7046.8 7065.3 7067.9 7070.0 7084.0 6889.8 6913.6 6921.0 6940.3 6946.0 09:59:50 INFO - PROCESS | 1665 | 09:59:50 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:18813.41 Median:25440.70 stddev:26459.24 (104.0%) stddev-sans-first:26498.59 09:59:50 INFO - PROCESS | 1665 | Values: 722.1 728.7 768.6 785.5 818.7 15504.4 15626.0 15656.5 15661.0 17859.4 16615.0 16644.0 16656.4 16657.9 16658.3 795.8 965.6 977.2 979.9 981.9 805.0 984.2 996.3 998.2 998.2 921.2 1041.0 1046.6 1048.0 1050.9 827.0 992.3 1034.9 1042.2 1043.9 767.7 771.9 775.6 775.8 776.4 15553.5 15642.5 15643.1 15656.8 15672.3 13122.0 13213.5 13305.4 13320.5 13494.8 10219.3 10312.5 10407.8 10668.2 10698.4 3504.7 3582.4 3586.1 3603.9 3613.5 84546.0 87163.0 87516.6 87842.6 89595.6 10058.5 10146.3 10292.4 10292.9 10698.0 23277.0 23565.9 23576.4 23589.8 24267.4 7918.4 8039.7 8049.3 8103.7 8181.2 4189.3 4223.7 4240.3 4277.3 4292.7 3666.5 3716.3 3717.5 3718.4 3723.8 660.1 672.6 673.9 675.0 677.3 491.8 549.9 557.7 574.8 592.4 7989.6 8042.0 8191.3 8267.8 8326.1 482.1 510.7 567.0 571.1 574.5 3285.6 3697.9 3705.7 3748.5 3803.6 89488.6 90849.5 91048.1 97155.0 97948.0 73975.3 75849.5 76880.6 77138.0 78417.0 68509.7 68527.3 69764.3 69775.3 70120.3 7791.3 8244.7 8263.9 8335.3 8374.4 49099.0 50370.7 52763.0 52966.7 53375.5 69089.6 70315.6 72720.0 76790.2 76888.6 10468.6 10560.9 10785.3 10938.0 11124.9 10051.9 10070.9 10457.8 10554.4 10599.6 10786.7 10856.7 11043.3 11146.2 11301.6 10656.4 10879.9 11294.8 11334.4 11370.4 10917.9 10932.6 10988.1 11038.6 11702.5 9030.6 9252.5 9307.1 9456.1 9474.4 9053.5 9511.0 9521.6 9560.4 9593.3 09:59:50 INFO - PROCESS | 1665 | -------- Summary: end -------- 09:59:50 INFO - PROCESS | 1665 | 09:59:50 INFO - TEST-INFO | 1665: exit 0 09:59:50 INFO - TEST-OK | dromaeo_css | took 1113829ms 09:59:50 INFO - TEST-START | kraken 09:59:50 INFO - operating with platform_type : mac_ 09:59:50 INFO - Initialising browser for kraken test... 09:59:50 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmp44dmoz/profile http://localhost:49280/getInfo.html) 09:59:52 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 09:59:52 INFO - PROCESS | 1675 | colorDepth:24 09:59:52 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 09:59:52 INFO - PROCESS | 1675 | __metrics 09:59:52 INFO - PROCESS | 1675 | 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" 09:59:52 INFO - PROCESS | 1675 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:59:53 INFO - TEST-INFO | 1675: exit 0 09:59:53 INFO - Browser initialized. 09:59:53 INFO - Running cycle 1/1 for kraken test... 09:59:53 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmp44dmoz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:00:05 INFO - PROCESS | 1677 | RSS: Main: 210300928 10:00:05 INFO - PROCESS | 1677 | 10:00:07 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 10:00:08 INFO - PROCESS | 1677 | RSS: Main: 264683520 10:00:08 INFO - PROCESS | 1677 | 10:00:11 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 10:00:11 INFO - PROCESS | 1677 | RSS: Main: 276000768 10:00:11 INFO - PROCESS | 1677 | 10:00:14 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 10:00:15 INFO - PROCESS | 1677 | RSS: Main: 264216576 10:00:15 INFO - PROCESS | 1677 | 10:00:17 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 10:00:18 INFO - PROCESS | 1677 | RSS: Main: 266330112 10:00:18 INFO - PROCESS | 1677 | 10:00:20 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:00:20 INFO - PROCESS | 1677 | RSS: Main: 268005376 10:00:20 INFO - PROCESS | 1677 | 10:00:23 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 10:00:23 INFO - PROCESS | 1677 | RSS: Main: 268222464 10:00:23 INFO - PROCESS | 1677 | 10:00:26 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 10:00:27 INFO - PROCESS | 1677 | RSS: Main: 266952704 10:00:27 INFO - PROCESS | 1677 | 10:00:30 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 10:00:30 INFO - PROCESS | 1677 | RSS: Main: 268414976 10:00:30 INFO - PROCESS | 1677 | 10:00:32 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:00:32 INFO - PROCESS | 1677 | RSS: Main: 301404160 10:00:32 INFO - PROCESS | 1677 | 10:00:34 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:00:35 INFO - PROCESS | 1677 | RSS: Main: 302780416 10:00:35 INFO - PROCESS | 1677 | 10:00:37 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:00:38 INFO - PROCESS | 1677 | RSS: Main: 307208192 10:00:38 INFO - PROCESS | 1677 | 10:00:40 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:00:41 INFO - PROCESS | 1677 | RSS: Main: 308011008 10:00:41 INFO - PROCESS | 1677 | 10:00:43 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:00:44 INFO - PROCESS | 1677 | RSS: Main: 309436416 10:00:44 INFO - PROCESS | 1677 | 10:00:46 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 10:00:46 INFO - PROCESS | 1677 | RSS: Main: 368574464 10:00:46 INFO - PROCESS | 1677 | 10:00:46 INFO - PROCESS | 1677 | __start_tp_report 10:00:46 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 10:00:46 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 10:00:46 INFO - PROCESS | 1677 | |i|pagename|runs| 10:00:46 INFO - PROCESS | 1677 | |0;ai-astar;111;108;110;109;112;111;119;109;110;110 10:00:46 INFO - PROCESS | 1677 | |1;audio-beat-detection;155;116;141;149;118;137;119;140;179;147 10:00:46 INFO - PROCESS | 1677 | |2;audio-dft;183;185;181;184;184;183;186;183;183;183 10:00:46 INFO - PROCESS | 1677 | |3;audio-fft;74;77;72;120;68;73;76;84;142;60 10:00:46 INFO - PROCESS | 1677 | |4;audio-oscillator;89;101;130;80;77;84;117;77;78;118 10:00:46 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;88;84;87;84;87;83;87;84;87;83 10:00:46 INFO - PROCESS | 1677 | |6;imaging-darkroom;92;107;148;93;92;93;93;93;93;92 10:00:46 INFO - PROCESS | 1677 | |7;imaging-desaturate;85;87;84;84;111;131;134;85;84;85 10:00:46 INFO - PROCESS | 1677 | |8;json-parse-financial;57;61;60;60;60;60;60;68;52;52 10:00:46 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;63;62;74;76;70;68;66;66;67;66 10:00:46 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;79;85;104;105;85;78;78;81;81;83 10:00:46 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;134;125;125;138;107;127;123;126;126;124 10:00:46 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;135;122;133;132;131;133;133;133;134;132 10:00:46 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;67;64;66;65;66;64;66;64;64;64 10:00:46 INFO - PROCESS | 1677 | __end_tp_report 10:00:46 INFO - PROCESS | 1677 | __start_cc_report 10:00:46 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1210 10:00:46 INFO - PROCESS | 1677 | __end_cc_report 10:00:46 INFO - PROCESS | 1677 | __startTimestamp1458838846263__endTimestamp 10:00:46 INFO - PROCESS | 1677 | 10:00:46 INFO - PROCESS | 1677 | ------- Summary: start ------- 10:00:46 INFO - PROCESS | 1677 | Number of tests: 14 10:00:46 INFO - PROCESS | 1677 | 10:00:46 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:110.90 Median:110.50 stddev:3.07 (2.8%) stddev-sans-first:3.26 10:00:46 INFO - PROCESS | 1677 | Values: 111.0 108.0 110.0 109.0 112.0 111.0 119.0 109.0 110.0 110.0 10:00:46 INFO - PROCESS | 1677 | 10:00:46 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:144.00 stddev:19.40 (13.5%) stddev-sans-first:19.81 10:00:46 INFO - PROCESS | 1677 | Values: 155.0 116.0 141.0 149.0 118.0 137.0 119.0 140.0 179.0 147.0 10:00:46 INFO - PROCESS | 1677 | 10:00:46 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:183.50 Median:183.50 stddev:1.35 (0.7%) stddev-sans-first:1.42 10:00:46 INFO - PROCESS | 1677 | Values: 183.0 185.0 181.0 184.0 184.0 183.0 186.0 183.0 183.0 183.0 10:00:46 INFO - PROCESS | 1677 | 10:00:46 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:84.60 Median:73.50 stddev:25.75 (35.0%) stddev-sans-first:27.02 10:00:46 INFO - PROCESS | 1677 | Values: 74.0 77.0 72.0 120.0 68.0 73.0 76.0 84.0 142.0 60.0 10:00:46 INFO - PROCESS | 1677 | 10:00:46 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:77.50 stddev:19.98 (25.8%) stddev-sans-first:21.07 10:00:46 INFO - PROCESS | 1677 | Values: 89.0 101.0 130.0 80.0 77.0 84.0 117.0 77.0 78.0 118.0 10:00:46 INFO - PROCESS | 1677 | 10:00:46 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:85.40 Median:87.00 stddev:1.96 (2.2%) stddev-sans-first:1.83 10:00:46 INFO - PROCESS | 1677 | Values: 88.0 84.0 87.0 84.0 87.0 83.0 87.0 84.0 87.0 83.0 10:00:46 INFO - PROCESS | 1677 | 10:00:46 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:99.60 Median:93.00 stddev:17.60 (18.9%) stddev-sans-first:18.45 10:00:46 INFO - PROCESS | 1677 | Values: 92.0 107.0 148.0 93.0 92.0 93.0 93.0 93.0 93.0 92.0 10:00:46 INFO - PROCESS | 1677 | 10:00:46 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:84.50 stddev:20.44 (24.2%) stddev-sans-first:21.21 10:00:46 INFO - PROCESS | 1677 | Values: 85.0 87.0 84.0 84.0 111.0 131.0 134.0 85.0 84.0 85.0 10:00:46 INFO - PROCESS | 1677 | 10:00:46 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:60.00 stddev:4.62 (7.7%) stddev-sans-first:4.84 10:00:46 INFO - PROCESS | 1677 | Values: 57.0 61.0 60.0 60.0 60.0 60.0 60.0 68.0 52.0 52.0 10:00:46 INFO - PROCESS | 1677 | 10:00:46 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:67.50 stddev:4.44 (6.6%) stddev-sans-first:4.36 10:00:46 INFO - PROCESS | 1677 | Values: 63.0 62.0 74.0 76.0 70.0 68.0 66.0 66.0 67.0 66.0 10:00:46 INFO - PROCESS | 1677 | 10:00:46 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:81.00 stddev:10.13 (12.5%) stddev-sans-first:10.43 10:00:46 INFO - PROCESS | 1677 | Values: 79.0 85.0 104.0 105.0 85.0 78.0 78.0 81.0 81.0 83.0 10:00:46 INFO - PROCESS | 1677 | 10:00:46 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:126.00 stddev:8.05 (6.4%) stddev-sans-first:7.92 10:00:46 INFO - PROCESS | 1677 | Values: 134.0 125.0 125.0 138.0 107.0 127.0 123.0 126.0 126.0 124.0 10:00:46 INFO - PROCESS | 1677 | 10:00:46 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:131.80 Median:133.00 stddev:3.61 (2.7%) stddev-sans-first:3.64 10:00:46 INFO - PROCESS | 1677 | Values: 135.0 122.0 133.0 132.0 131.0 133.0 133.0 133.0 134.0 132.0 10:00:46 INFO - PROCESS | 1677 | 10:00:46 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.50 stddev:1.15 (1.8%) stddev-sans-first:0.97 10:00:46 INFO - PROCESS | 1677 | Values: 67.0 64.0 66.0 65.0 66.0 64.0 66.0 64.0 64.0 64.0 10:00:46 INFO - PROCESS | 1677 | -------- Summary: end -------- 10:00:46 INFO - PROCESS | 1677 | 10:00:46 INFO - TEST-INFO | 1677: exit 0 10:00:46 INFO - TEST-OK | kraken | took 56423ms 10:00:46 INFO - SUITE-END | took 1170s 10:00:47 INFO - Completed test suite (00:19:30) 10:00:47 INFO - javascript benchmark 10:00:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3456.2223499712554, 3480.443129099345, 3509.66658167474, 3511.6137224905256, 3552.3960926642467, 5869.471747542721, 5872.295324561053, 5884.4409781070835, 5913.970430147849, 5936.851578710534, 5853.7365818538165, 5887.8233652990375, 5903.4686878180955, 5903.586748927577, 5919.792807251747, 5189.922151167735, 5238.240455134013, 5242.55438287746, 5259.579233661298, 5306.495882891119, 5274.208868669711, 5276.0, 5276.419593844674, 5277.234800953878, 5278.524932756051, 5266.8683282917855, 5268.894622107556, 5314.92027619586, 5319.574434045287, 5350.5452036576935, 5326.786928522854, 5343.973280133613, 5366.517013468787, 5366.597505187126, 5389.595780316453, 5077.111505486525, 5281.339832520935, 5296.947030529684, 5301.0723123453245, 5305.257263983045, 5778.075507918713, 5790.652560846321, 5848.619839710405, 5850.268716410449, 5868.911966320508, 6230.657313847737, 6306.306306306303, 6309.305976342599, 6329.620222786648, 6340.651264180515, 6239.594426362272, 6260.0, 6290.716917738713, 6313.179286692746, 6340.0, 5986.0, 6009.819705408801, 6018.368071352533, 6019.036954087325, 6032.758689652364, 6211.875762484725, 6292.244930608356, 6371.904421433682, 6388.201474815648, 6388.776392826322, 6307.148534947815, 6307.24313082433, 6312.6212427253595, 6324.33594472583, 6324.9051264231075, 6290.087937249074, 6296.590721603081, 6301.7164227609865, 6317.589356691892, 6322.683865806784, 5316.175992721134, 6149.831532008904, 6267.843303917347, 6283.497320214372, 6365.3316401778075, 6281.277653069956, 6298.779542715983, 6301.338359472281, 6309.652969086745, 6326.145970294044, 4331.696781225347, 4889.217725164028, 4974.9751251243515, 4975.651704380731, 4993.400791904995, 4401.977990110029, 4510.909781804346, 4525.570070843265, 4550.089982003613, 4558.361829343895, 5709.42905709434, 5769.134629805562, 5780.710964451845, 5783.913241301384, 5784.479396854219, 5151.716655583904, 6072.724727807122, 6181.938180618136, 6335.11308416822, 6339.397757213057, 5209.088409528317, 5776.595638305363, 5846.649201047951, 5848.912266316009, 5852.678102704307, 5344.839654810362, 5445.264889239981, 5450.754716037788, 5451.3458384994055, 5480.588955828249, 6314.55798094129, 6336.334684858116, 6392.904106438407, 6480.222373315044, 6529.053287273224, 6283.622982621057, 6311.400416960381, 6311.715972781328, 6312.147860038836, 6318.84202894913, 6292.559520833498, 6421.293657697556, 6471.191101112361, 6483.351664833479, 6486.772962946275, 6223.3465486123305, 6268.811935641938, 6296.905546416716, 6301.6219026858535, 6312.905306420499, 5331.280277162688, 6233.314335423009, 6279.120923070683, 6288.465480434032, 6320.336364681642, 5966.701664916824, 6161.568690191643, 6258.4680302173, 6262.09199666055, 6287.497000239879, 6157.84605384869, 6225.035119556476, 6231.906521402273, 6232.968835155795, 6241.812745617639, 5805.970970145122, 6058.3335833057445, 6083.0, 6083.908741368795, 6085.0, 6064.241969753781, 6169.876602468015, 6175.972927241891, 6178.258608966953, 6243.937560624518, 5334.573234141182, 6084.178635884099, 6115.635867915819, 6145.66198859067, 6173.135760993375], "unit": "score", "name": "dojo.html", "value": 5773.643595647511}, {"lowerIsBetter": false, "replicates": [498.8750367920339, 566.73363519146, 578.884223155369, 588.2822955993686, 650.8242774450898, 27531.862340688294, 40547.18905621886, 40883.99999999996, 41083.97290067742, 41177.382339264936, 44533.886652833695, 44869.32696009563, 44921.775391122996, 44947.72996565321, 45202.77398613011, 9800.0, 10030.0, 10035.749106272366, 10039.09648131668, 10045.748856278578, 9712.465814380206, 9810.656627018056, 9826.263030272723, 9828.557714902847, 9938.9503052485, 9920.00799920006, 9945.15466185375, 9957.45234012129, 9962.750931226705, 9978.251631127694, 9871.753206169868, 9935.950320248425, 9950.900490995069, 9952.800943981152, 9955.0, 8541.35939804511, 9753.366031207948, 9916.752081197956, 9919.603215871357, 9924.603015879356, 43306.78346608279, 43635.563644363465, 43649.0, 43713.0, 43726.344104838136, 3266.8039917604783, 3347.7321814255047, 3365.6297807241185, 3374.3926093303194, 3402.795832250073, 29873.95441159549, 30163.245918851986, 30297.545536816964, 30414.54378184329, 30543.69456305431, 2727.618133461317, 2781.3880946191807, 2810.283377738684, 2840.8011439199263, 2846.6299381080535, 370616.0, 370645.0, 371240.0, 371456.9999999973, 371794.0, 72041.27958720451, 72274.2772572278, 72309.27690723025, 72387.6380618104, 72608.27391726016, 75808.0, 76150.85773713399, 79863.0, 81253.59373203096, 81365.59317203375, 18689.532761680795, 18727.438176854717, 18936.62126757457, 18960.620787584172, 18965.241390344232, 14123.71752564943, 14294.571162865132, 14305.427782888568, 14307.92846035763, 14333.426662933574, 18371.540711482052, 23432.64851027236, 23456.76543234546, 23532.176373826835, 23917.80410979444, 8033.192531680442, 9828.149836547464, 9832.01679832011, 9835.704928852147, 9842.852357214648, 947.6304241345881, 1045.13253999182, 1064.2124827627654, 1127.2729089737074, 1135.4379830329963, 30581.847090764848, 30669.0, 30997.845010774803, 31338.0, 31487.685123148476, 940.6989763275686, 1163.5055101581793, 1198.6583823610404, 1200.327816422806, 1217.452146534063, 15753.369865205492, 16270.918645406933, 16276.43032493857, 16387.672246555, 16928.661426771396, 517847.0, 521805.0, 527166.7283327117, 534151.0, 534548.0, 62410.0638490423, 62982.685086574274, 63009.05486417707, 63016.0, 63157.68421157865, 1379.717157982611, 1413.9010269281257, 1529.05962832857, 1560.2120928931045, 1627.584965833705, 28908.566371504025, 29639.851800740857, 29824.0, 30298.939537116094, 30407.239819004702, 48348.0, 48714.756426217646, 48826.511734882195, 48933.51066489289, 48959.0, 323350.0, 325131.0, 325420.0, 326195.0, 326531.0, 35033.64966350304, 47709.28436073531, 49046.019079617494, 49759.0, 50534.241986369496, 47219.763901180275, 47361.28958065701, 48119.278210827564, 48903.0, 48944.28694995658, 37830.24339513249, 39253.03734813305, 39263.6257730978, 39379.40930885982, 39569.406458903715, 38598.42102368523, 38744.0, 38804.41793373158, 39538.40692389559, 39986.80006600065, 41056.1788764229, 41518.1696366077, 41590.792046039576, 41928.0, 42011.579884200764, 33376.66623333735, 34436.31127377489, 35156.64843351636, 35179.824100879334, 35702.46446303256, 25809.0, 27046.72953270521, 27097.885560373703, 27109.86445067762, 27126.1862144136], "unit": "score", "name": "ext.html", "value": 20773.052368983415}, {"lowerIsBetter": false, "replicates": [372.85831384074055, 378.63650895140665, 379.11476701901057, 379.2528718424704, 386.35478750486686, 20600.0, 20622.0, 20712.0, 21474.463138421546, 21554.245601403934, 12489.500419983213, 14818.110913345206, 19781.307654232103, 20302.0, 20303.984800759976, 4246.532881383061, 5298.655587386817, 5534.833954981357, 5540.058190107691, 5717.456841600041, 4109.28087584673, 4307.763073030982, 4349.782510874444, 6185.288691800455, 6186.938130618703, 6170.413810687977, 6172.47533959614, 6173.074038894157, 6173.382661733813, 6177.351378105302, 5632.493075623193, 5936.910946335808, 5938.198343223696, 5943.494802941756, 5958.314793798703, 3999.320115580358, 7134.857302853966, 7447.404207663374, 7450.366718828906, 7465.6267186641, 26505.072322468815, 26678.33304167392, 27434.862825685945, 28018.439631207464, 28042.85978570094, 2331.6852224949585, 2496.3259919821726, 2535.809814263919, 2621.0, 3161.9051428457183, 14773.556793296219, 15763.605909852231, 15772.447964321194, 15807.051576905422, 15933.681326373524, 1850.565117197471, 1885.4155211884222, 1953.9413817585496, 1961.686130219158, 1970.4876732049627, 100995.0, 108756.4562177184, 110747.44626276898, 113122.43438782835, 113318.43340783326, 19447.124879380463, 20115.698264526043, 20289.188432462535, 20319.288824891057, 20324.898375508026, 29823.10530684083, 29839.85080074586, 30196.849015754782, 30374.025688330188, 30447.695523044928, 11169.0, 11436.256643318158, 11464.25482343645, 11516.769664606662, 11621.954024137869, 8434.831303374021, 9360.344775865624, 9671.661491847752, 9707.514624268759, 9835.655752048644, 8753.649854005896, 8940.73177804667, 8964.8655270171, 9018.053104423941, 9048.049954754788, 2974.4051189761703, 3566.4472006838982, 3653.214558869856, 3701.5002974598624, 3714.888553343404, 925.153484561632, 975.5073687787622, 993.8062077894741, 1002.2032484175098, 1043.8173319669027, 19308.227670893288, 19731.309404170785, 20110.69833952492, 20218.191272349235, 20731.585368292548, 1000.474750755859, 1003.7239759066169, 1014.9847752283722, 1070.71626019105, 1120.9775804484027, 10406.219533535015, 10829.0, 10868.021878031015, 10894.346339219672, 11028.944855275673, 441158.0, 549502.0, 550078.0, 550370.0, 626902.0, 119142.40428797973, 122670.0, 126149.0, 132246.0, 138312.30843845717, 466.37039996005797, 485.44174199669953, 485.5993805110798, 488.21884984025274, 489.1562055454384, 11137.0, 11184.440777960906, 11481.483333250191, 11755.588554400554, 11933.045356371296, 48850.022999540524, 50583.0, 52476.21285680794, 52773.7361313191, 53151.0, 61045.47386315378, 71543.64228178826, 75360.0, 76835.0, 78452.60773696096, 6880.827979300558, 8063.435559511013, 8179.591020448835, 8221.424500284922, 8577.356698247531, 8552.786180345542, 11725.0, 13138.0, 13613.11514751538, 13669.726605467637, 9707.466089365153, 11438.771224575295, 11681.299122052704, 12037.518499259932, 12122.575709850113, 11300.547978081113, 11322.773544529227, 11380.487878045342, 11464.0, 11653.475593598478, 10611.363318200933, 10814.188935829687, 11852.585159519376, 12130.757384852077, 12202.572909948465, 8313.0, 8342.29090527312, 8497.957510212409, 8577.699780507652, 8690.91309086901, 8919.375643705138, 9727.464989425649, 11662.650120496399, 11765.352905590275, 11906.345151016778], "unit": "score", "name": "jquery.html", "value": 10177.178446957238}, {"lowerIsBetter": false, "replicates": [1443.549233020814, 1624.1392062207028, 1651.4385109062916, 1982.7125066865306, 2064.2259152817683, 7547.698092076317, 8804.691835785748, 8890.288776897849, 8890.466572005676, 8892.377533572653, 8383.958080209606, 8602.827943441127, 8607.225349718525, 8625.266852317545, 8632.697855575056, 2259.3222033389998, 2468.123816045305, 2491.377155711072, 2514.1326242446326, 2523.785478234343, 2564.6153077038407, 2564.9358766030814, 2567.4993376291536, 2575.2403041102825, 2576.1498705427257, 2439.817013723969, 2501.3621526510715, 2504.0, 2505.3736565858535, 2508.636247744076, 2471.6045432730766, 2511.3344963584664, 2565.2688983639573, 2567.281161274846, 2571.0101610879947, 2507.2979565721625, 2542.5423423783714, 2546.987265063681, 2570.4088059746177, 2574.292069680834, 9092.8636070459, 9174.266058715286, 9191.770205744842, 9207.631694732203, 9322.673706420243, 5526.972365138148, 5635.267415236034, 5673.886522269573, 5693.943060569424, 5698.886022279573, 3437.3984552703428, 3528.4883691864793, 3728.5712143103347, 3731.197792474604, 3744.8876533704033, 1039.5270152080861, 1062.4475272858149, 1069.764651776608, 1082.2856914436434, 1109.362116782845, 10623.52194151265, 11910.821337680029, 12277.57028504007, 12308.015358771278, 12331.445084971198, 4943.9258411123865, 5008.749562521859, 5097.209932460474, 5100.69395836251, 5102.872428189325, 10431.321964072311, 10480.895191047992, 10483.318584292148, 10507.317024393544, 10512.63205787809, 4764.952350476451, 5625.09998400254, 5628.915566266509, 5629.887402251932, 5635.154726791015, 4469.575390337913, 4603.677742558056, 4901.754912254373, 4978.950210497921, 5007.974960125176, 3528.523649307362, 4057.5542402426677, 4098.918021639551, 4152.480939882515, 4197.370394440858, 1298.480607756886, 1374.896882733799, 1375.4910683047137, 1386.0990356268505, 1388.0, 1399.237415608496, 1409.1685905315912, 1452.3319273134266, 1453.5276035288573, 1460.4231328625133, 8188.303994160444, 8393.958030209931, 8413.957930210432, 8424.326053915673, 8425.747227583182, 521.9164933610604, 527.7704198673589, 527.862755683525, 530.482779290189, 545.4572700163284, 6311.084892690534, 6365.49076073913, 6412.583182093149, 6451.903221451682, 6452.741890324428, 10517.789644207072, 10942.890571094187, 10999.120070394349, 11028.944855275833, 11032.28290161137, 10400.115990140923, 10767.246292759432, 10802.297850639683, 10837.133029357632, 10854.0, 8497.44766590182, 8506.0, 8553.74338769838, 8568.443051201652, 8593.0, 7871.370290376871, 7949.125596184531, 8013.278804907353, 8064.596770161351, 8101.108878023295, 9481.905180948102, 9759.46322952216, 9786.168175705145, 9889.851652225367, 9949.403035817873, 9801.754956126153, 10085.949570252102, 10237.641682541076, 10302.587896484056, 10310.742231444274, 7665.3101220890385, 7685.615719214129, 7733.265339792711, 7775.805604859697, 7790.493617914817, 8405.285550728257, 8435.493870367798, 8488.787780305542, 8501.829963400822, 8503.404761666625, 7430.665620047219, 7556.319931206218, 7643.0, 7659.961700191463, 7761.534307941316, 7385.926140738524, 7518.624068796429, 7529.435292352986, 7645.847083058419, 7682.462227644011, 6986.580805151707, 7781.299683028555, 7979.9202007979175, 8006.119326874155, 8007.279344858757, 7212.675429605785, 7231.385332246818, 7274.927250727636, 7291.34377905991, 7306.6711997959155, 7322.926770732224, 7354.77935661931, 7413.925860741324, 7416.888746668912, 7417.0], "unit": "score", "name": "mootools.html", "value": 4974.9014475403255}, {"lowerIsBetter": false, "replicates": [332.53352714528927, 335.4465132531325, 336.63138862945067, 342.11051266706556, 347.16679968076613, 6588.407043366096, 6590.835229119274, 6608.702608382617, 6646.302138275484, 6648.900266496001, 5441.8572099859075, 6524.934750652492, 6535.281119076898, 6538.934610653892, 6568.80293591193, 4048.2915489789316, 4358.866694659396, 4690.226112691402, 4711.340412342275, 4760.881192919661, 4682.41469816273, 4701.882452938669, 4714.787834547454, 4722.787474563635, 4808.975955120237, 4723.362346083286, 4738.763061846911, 4739.218029025206, 4751.216049351853, 4758.6668933174515, 4291.605228300799, 4334.848280310174, 4749.0027094310235, 4780.95219047812, 4791.634384200521, 3314.3371325734947, 3899.883003509871, 3997.120633460663, 4007.358822588401, 4118.155778065489, 6078.483328917047, 6303.086052522404, 6351.872962540723, 6364.395382438707, 6366.490680745529, 4670.976645116787, 5608.355039170507, 5647.632903861277, 5661.433856614347, 5668.0, 7031.085958825372, 7031.226565077837, 7033.824154396129, 7039.894401583981, 7050.400715939151, 4624.722516648978, 4641.9535804641855, 4648.418947631546, 4669.929951050737, 4672.766361681903, 5965.970170149165, 7122.821929451753, 7418.554886706869, 7423.109226892753, 7430.14553326369, 4737.739424331626, 4754.762261886892, 4757.167495688241, 4761.523847615211, 4769.332293478916, 4834.178189707758, 4839.104765618372, 4844.224924012141, 4848.175810112219, 4865.318855360252, 4605.194091034055, 5658.321001479849, 5662.235598194274, 5674.574406919498, 5683.8863222736145, 6391.201099862517, 6688.498362622823, 7009.474289428314, 7031.191412987469, 7050.365467107882, 1553.3631211203353, 1628.6009927567823, 1629.714799910011, 1629.8451647093507, 1633.8447847454472, 883.7260449260622, 1019.4036488654073, 1031.6492392586556, 1035.89123142069, 1045.362328979322, 6417.711202995783, 6468.773592924225, 6472.611643301417, 6475.190601174853, 6480.643564603898, 6967.512274140761, 7092.716291348392, 7222.422206223489, 7254.020707204565, 7256.346928776436, 6322.747090116436, 6406.391392817675, 6527.608343499405, 6534.477241820643, 6539.117219175446, 3825.3114439401174, 3880.320943834874, 3884.0484081400236, 3890.105275786585, 3894.805259737002, 7660.80847978805, 7662.1571627120975, 7680.078390593053, 7682.692692292358, 7689.231076892266, 7269.563826170447, 7551.5846628434865, 7551.924480755232, 7586.734464293723, 7592.0130383050955, 7594.848103037908, 7601.315881570575, 7614.428917831296, 7633.160352361236, 7635.007449031701, 5891.911621325769, 7279.59962202084, 7283.781486555412, 7295.781126566211, 7315.646605378022, 7164.176119746296, 7172.924061390833, 7177.677004534704, 7178.605176715122, 7181.0, 7277.708891644275, 7563.8109047272055, 7642.770716878503, 7643.0, 7678.347340476123, 4007.979960100181, 4618.907621847611, 4666.393368862026, 4669.7431641260055, 4684.0, 5922.703864806828, 7275.345218930322, 7284.745033923788, 7294.161171465137, 7294.562326260441, 7062.611556364449, 7063.894041589483, 7072.504924655224, 7075.257098004841, 7089.503734738519, 6718.462522998051, 7049.436045116481, 7060.929390706027, 7065.646717664199, 7074.469414794014, 6816.454683625199, 6855.520113592001, 6864.4165245954655, 6866.931330686829, 6869.244383117953, 7046.753363632249, 7065.258147894603, 7067.8901283435125, 7070.0, 7084.0, 6889.793306200822, 6913.5506192097355, 6920.9653951729915, 6940.271271516418, 6945.965270173819], "unit": "score", "name": "prototype.html", "value": 5095.739716480926}, {"lowerIsBetter": false, "replicates": [722.115408624435, 728.7449392712555, 768.5964868444066, 785.4737325991581, 818.6602559937626, 15504.379824807009, 15626.0, 15656.452024179142, 15661.0, 17859.374921877738, 16615.0, 16644.0, 16656.417025404113, 16657.916710416463, 16658.250378732955, 795.7891158842912, 965.5896244096249, 977.2231076294328, 979.9020097990215, 981.906718861707, 804.9758507244762, 984.1831280037552, 996.3324572536418, 998.1515711645117, 998.1765043838826, 921.1709461484651, 1041.0370407373186, 1046.5865982936734, 1048.0201012053753, 1050.8633877595903, 827.0323721246157, 992.2756387836884, 1034.8602938603267, 1042.1662669864115, 1043.8590790243334, 767.6583920155533, 771.8880762289492, 775.577310365852, 775.7556369743513, 776.4409625069941, 15553.533393998197, 15642.452514162063, 15643.061416315057, 15656.765148522782, 15672.294746736425, 13121.950243980555, 13213.471461141542, 13305.40125694346, 13320.533781317705, 13494.797578036338, 10219.335743176669, 10312.484375781181, 10407.843882341771, 10668.199885008655, 10698.358098514114, 3504.6554749678107, 3582.4268117101137, 3586.1393265616325, 3603.891883243507, 3613.5483064616924, 84546.0, 87163.0, 87516.56241718815, 87842.5607871963, 89595.55202224012, 10058.497075146213, 10146.340487868265, 10292.382457052601, 10292.897071029343, 10698.0, 23276.961077248066, 23565.882170589037, 23576.41058973505, 23589.7641023591, 24267.39331516726, 7918.366530677532, 8039.678412863537, 8049.315808156255, 8103.6758529658155, 8181.222783835526, 4189.287821070426, 4223.704340696122, 4240.3427468741775, 4277.272863613193, 4292.678049146327, 3666.5416822897137, 3716.349638813197, 3717.498137751369, 3718.4422336649177, 3723.7765734056043, 660.1088530483809, 672.5661948043485, 673.8685956238486, 675.0144788608686, 677.2719326723792, 491.76395330241684, 549.9367572729108, 557.7133751618333, 574.8332983434757, 592.4283066840519, 7989.600519973978, 8042.03495580534, 8191.344692424592, 8267.8346433071, 8326.12575679557, 482.10088185534426, 510.6629624447847, 566.9546436285087, 571.1261769492683, 574.5145352177403, 3285.589301337333, 3697.8890633281044, 3705.6850167735506, 3748.493953316322, 3803.5816060233906, 89488.5525572381, 90849.54575227082, 91048.08951910528, 97155.0, 97948.0, 73975.26024739792, 75849.48301033948, 76880.61559692166, 77138.0, 78417.0, 68509.65745171341, 68527.31472685309, 69764.3023569768, 69775.3022469779, 70120.2987970124, 7791.298783109547, 8244.711435099982, 8263.917360826315, 8335.291500222549, 8374.37192210599, 49099.018019638694, 50370.74073148201, 52763.0, 52966.735166323924, 53375.46624533705, 69089.61820763657, 70315.59368812697, 72720.0, 76790.23209767831, 76888.61555692185, 10468.581256749645, 10560.894391055992, 10785.298955567863, 10938.0, 11124.944375278395, 10051.949740251252, 10070.899291007288, 10457.790844182922, 10554.419506926886, 10599.576016959236, 10786.676399708022, 10856.728581785203, 11043.337399756041, 11146.164037697043, 11301.604443844426, 10656.360618362924, 10879.945600271947, 11294.774104517699, 11334.433278335886, 11370.374629395463, 10917.890821091687, 10932.617358392417, 10988.120950324115, 11038.613648522263, 11702.476709386621, 9030.593623286837, 9252.49111298858, 9307.11582399671, 9456.101670341306, 9474.431534107976, 9053.456792592466, 9511.0, 9521.571529281338, 9560.426374417557, 9593.28050396209], "unit": "score", "name": "yui.html", "value": 7066.650445767737}], "name": "dromaeo_css", "value": 7761.935169260004}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 110.0, 109.0, 112.0, 111.0, 119.0, 109.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [155.0, 116.0, 141.0, 149.0, 118.0, 137.0, 119.0, 140.0, 179.0, 147.0], "unit": "score", "name": "audio-beat-detection", "value": 140.1}, {"lowerIsBetter": true, "replicates": [183.0, 185.0, 181.0, 184.0, 184.0, 183.0, 186.0, 183.0, 183.0, 183.0], "unit": "score", "name": "audio-dft", "value": 183.5}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 72.0, 120.0, 68.0, 73.0, 76.0, 84.0, 142.0, 60.0], "unit": "score", "name": "audio-fft", "value": 84.6}, {"lowerIsBetter": true, "replicates": [89.0, 101.0, 130.0, 80.0, 77.0, 84.0, 117.0, 77.0, 78.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 95.1}, {"lowerIsBetter": true, "replicates": [88.0, 84.0, 87.0, 84.0, 87.0, 83.0, 87.0, 84.0, 87.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.4}, {"lowerIsBetter": true, "replicates": [92.0, 107.0, 148.0, 93.0, 92.0, 93.0, 93.0, 93.0, 93.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 99.6}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 84.0, 84.0, 111.0, 131.0, 134.0, 85.0, 84.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [57.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 68.0, 52.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 59.0}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 74.0, 76.0, 70.0, 68.0, 66.0, 66.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [79.0, 85.0, 104.0, 105.0, 85.0, 78.0, 78.0, 81.0, 81.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [134.0, 125.0, 125.0, 138.0, 107.0, 127.0, 123.0, 126.0, 126.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.5}, {"lowerIsBetter": true, "replicates": [135.0, 122.0, 133.0, 132.0, 131.0, 133.0, 133.0, 133.0, 134.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 131.8}, {"lowerIsBetter": true, "replicates": [67.0, 64.0, 66.0, 65.0, 66.0, 64.0, 66.0, 64.0, 64.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.0}], "name": "kraken", "value": 1431.2}]} 10:00:47 INFO - Return code: 0 10:00:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:00:47 INFO - # TBPL SUCCESS # 10:00:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:00:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:00:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:00:47 INFO - 2016-03-24 10:00:47.566 screenresolution[1681:10020] starting screenresolution argv=screenresolution get 10:00:47 INFO - 2016-03-24 10:00:47.569 screenresolution[1681:10020] Display 0: 1600x1200x32@60 10:00:47 INFO - 2016-03-24 10:00:47.575 screenresolution[1682:10023] starting screenresolution argv=screenresolution list 10:00:47 INFO - Available Modes on Display 0 10:00:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:00:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:00:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:00:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:00:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:00:47 INFO - Intel Iris: 10:00:47 INFO - Chipset Model: Intel Iris 10:00:47 INFO - Type: GPU 10:00:47 INFO - Bus: Built-In 10:00:47 INFO - VRAM (Dynamic, Max): 1536 MB 10:00:47 INFO - Vendor: Intel (0x8086) 10:00:47 INFO - Device ID: 0x0a2e 10:00:47 INFO - Revision ID: 0x0009 10:00:47 INFO - Displays: 10:00:47 INFO - Display: 10:00:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:00:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:00:47 INFO - Display Serial Number: 1600x1200 60 10:00:47 INFO - Main Display: Yes 10:00:47 INFO - Mirror: Off 10:00:47 INFO - Online: Yes 10:00:47 INFO - Rotation: Supported 10:00:47 INFO - Return code: 0 10:00:47 INFO - Running post-action listener: _resource_record_post_action 10:00:47 INFO - Running post-run listener: _resource_record_post_run 10:00:48 INFO - Total resource usage - Wall time: 1204s; CPU: 52.0%; Read bytes: 37578240; Write bytes: 663373824; Read time: 394; Write time: 1894 10:00:48 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 361658880; Write bytes: 362772480; Read time: 28118; Write time: 701 10:00:48 INFO - run-tests - Wall time: 1173s; CPU: 52.0%; Read bytes: 35796480; Write bytes: 299311104; Read time: 375; Write time: 1152 10:00:48 INFO - Running post-run listener: _upload_blobber_files 10:00:48 INFO - Blob upload gear active. 10:00:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:00:48 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 10:00:48 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'] 10:00:48 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 10:00:49 INFO - (blobuploader) - INFO - Open directory for files ... 10:00:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:00:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:00:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:51 INFO - (blobuploader) - INFO - Done attempting. 10:00:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:00:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:00:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:52 INFO - (blobuploader) - INFO - Done attempting. 10:00:52 INFO - (blobuploader) - INFO - Iteration through files over. 10:00:52 INFO - Return code: 0 10:00:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:00:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:00:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb12fe6c5eece203de225f88d7cfdbf98fe55a3921313afc29fd76f41c67394a7a812009beca955a2bf7293a519d782315e71863a7ef0442286435d92a6f740b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6bc60aec0b34b9b65a95196d9cab792b8cb8ba8c95a229fe6c615ce6f65c8e637a1a67910d546652b46d46de0a4eb25e0536531473d89be8db408333bf73f3b1"} 10:00:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:00:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:00:52 INFO - Contents: 10:00:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb12fe6c5eece203de225f88d7cfdbf98fe55a3921313afc29fd76f41c67394a7a812009beca955a2bf7293a519d782315e71863a7ef0442286435d92a6f740b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6bc60aec0b34b9b65a95196d9cab792b8cb8ba8c95a229fe6c615ce6f65c8e637a1a67910d546652b46d46de0a4eb25e0536531473d89be8db408333bf73f3b1"} 10:00:52 INFO - Running post-run listener: copy_logs_to_upload_dir 10:00:52 INFO - Copying logs to upload dir... 10:00:52 INFO - mkdir: /builds/slave/test/build/upload/logs 10:00:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.575648 ========= master_lag: 5.46 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-03-24 10:00:57.764989) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 10:00:57.768249) ========= 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.53dtWUXQxF/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.LFyasPIJXH/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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/bb12fe6c5eece203de225f88d7cfdbf98fe55a3921313afc29fd76f41c67394a7a812009beca955a2bf7293a519d782315e71863a7ef0442286435d92a6f740b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6bc60aec0b34b9b65a95196d9cab792b8cb8ba8c95a229fe6c615ce6f65c8e637a1a67910d546652b46d46de0a4eb25e0536531473d89be8db408333bf73f3b1"} build_url:https://queue.taskcluster.net/v1/task/X4gfkRzVQy-yftBSNYiC1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010624 build_url: 'https://queue.taskcluster.net/v1/task/X4gfkRzVQy-yftBSNYiC1Q/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/bb12fe6c5eece203de225f88d7cfdbf98fe55a3921313afc29fd76f41c67394a7a812009beca955a2bf7293a519d782315e71863a7ef0442286435d92a6f740b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6bc60aec0b34b9b65a95196d9cab792b8cb8ba8c95a229fe6c615ce6f65c8e637a1a67910d546652b46d46de0a4eb25e0536531473d89be8db408333bf73f3b1"}' ========= master_lag: 0.20 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 10:00:57.976528) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 10:00:57.976870) ========= 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.53dtWUXQxF/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.LFyasPIJXH/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.005099 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 10:00:58.055837) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 10:00:58.056823) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 10:00:58.059320) ========= ========= Total master_lag: 6.47 =========