builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0182 starttime: 1458120337.55 results: success (0) buildid: 20160316004053 builduid: 38b89a7b29a94ad4bcde7995c0eeddef revision: bbdaba90d893f6fa09fdb287bf3d6227adda3457 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 02:25:37.547185) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 02:25:37.548814) ========= ========= Started set props: basedir (results: 0, elapsed: 1 secs) (at 2016-03-16 02:25:37.549106) ========= 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.QyiU4Yqo38/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.RLiyTZVeyQ/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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.005512 basedir: '/builds/slave/test' ========= master_lag: 1.63 ========= ========= Finished set props: basedir (results: 0, elapsed: 1 secs) (at 2016-03-16 02:25:39.182040) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 7 secs) (at 2016-03-16 02:25:39.182362) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 7 secs) (at 2016-03-16 02:25:46.473152) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 02:25:46.473408) ========= 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.QyiU4Yqo38/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.RLiyTZVeyQ/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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.005938 ========= master_lag: 0.30 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 02:25:46.776229) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 02:25:46.776491) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 02:25:46.776846) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2016-03-16 02:25:46.777325) ========= 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.QyiU4Yqo38/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.RLiyTZVeyQ/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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-16 02:25:47-- 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% 16.5M=0.001s 2016-03-16 02:25:48 (16.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.597912 ========= master_lag: 6.48 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2016-03-16 02:25:53.850448) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 02:25:53.850728) ========= 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.QyiU4Yqo38/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.RLiyTZVeyQ/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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.026521 ========= master_lag: 0.18 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 02:25:54.052806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-03-16 02:25:54.053140) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bbdaba90d893f6fa09fdb287bf3d6227adda3457 --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 bbdaba90d893f6fa09fdb287bf3d6227adda3457 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QyiU4Yqo38/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.RLiyTZVeyQ/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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-16 02:25:54,422 truncating revision to first 12 chars 2016-03-16 02:25:54,422 Setting DEBUG logging. 2016-03-16 02:25:54,423 attempt 1/10 2016-03-16 02:25:54,423 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bbdaba90d893?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-16 02:25:55,476 unpacking tar archive at: mozilla-aurora-bbdaba90d893/testing/mozharness/ program finished with exit code 0 elapsedTime=1.305676 ========= master_lag: 4.82 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-03-16 02:26:00.181560) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 02:26:00.186532) ========= echo bbdaba90d893f6fa09fdb287bf3d6227adda3457 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'bbdaba90d893f6fa09fdb287bf3d6227adda3457'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QyiU4Yqo38/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.RLiyTZVeyQ/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 bbdaba90d893f6fa09fdb287bf3d6227adda3457 program finished with exit code 0 elapsedTime=0.005979 script_repo_revision: 'bbdaba90d893f6fa09fdb287bf3d6227adda3457' ========= master_lag: 0.29 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 02:26:00.484393) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 8 secs) (at 2016-03-16 02:26:00.484686) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 8 secs) (at 2016-03-16 02:26:08.771825) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-03-16 02:26:08.772084) ========= /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.QyiU4Yqo38/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.RLiyTZVeyQ/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 02:26:13 INFO - MultiFileLogger online at 20160316 02:26:13 in /builds/slave/test 02:26:13 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 02:26:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:26:13 INFO - {'append_to_log': False, 02:26:13 INFO - 'base_work_dir': '/builds/slave/test', 02:26:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:26:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:26:13 INFO - 'branch': 'Mozilla-Aurora', 02:26:13 INFO - 'buildbot_json_path': 'buildprops.json', 02:26:13 INFO - 'config_files': ('talos/mac_config.py',), 02:26:13 INFO - 'default_actions': ('clobber', 02:26:13 INFO - 'read-buildbot-config', 02:26:13 INFO - 'download-and-extract', 02:26:13 INFO - 'populate-webroot', 02:26:13 INFO - 'create-virtualenv', 02:26:13 INFO - 'install', 02:26:13 INFO - 'run-tests'), 02:26:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:26:13 INFO - 'download_minidump_stackwalk': True, 02:26:13 INFO - 'download_symbols': 'ondemand', 02:26:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:26:13 INFO - 'tooltool.py': '/tools/tooltool.py', 02:26:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:26:13 INFO - '/tools/misc-python/virtualenv.py')}, 02:26:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:26:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:26:13 INFO - 'installer_path': 'installer.exe', 02:26:13 INFO - 'log_level': 'info', 02:26:13 INFO - 'log_name': 'talos', 02:26:13 INFO - 'log_to_console': True, 02:26:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:26:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:26:13 INFO - 'opt_config_files': (), 02:26:13 INFO - 'pip_index': False, 02:26:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:26:13 INFO - 'cmd': ('bash', 02:26:13 INFO - '-c', 02:26:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:26:13 INFO - 'enabled': True, 02:26:13 INFO - 'halt_on_failure': False, 02:26:13 INFO - 'name': 'check_screen_resolution'},), 02:26:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:26:13 INFO - 'cmd': ('bash', 02:26:13 INFO - '-c', 02:26:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:26:13 INFO - 'enabled': True, 02:26:13 INFO - 'halt_on_failure': False, 02:26:13 INFO - 'name': 'check_screen_resolution'},), 02:26:13 INFO - 'run_cmd_checks_enabled': True, 02:26:13 INFO - 'sps_profile': False, 02:26:13 INFO - 'sps_profile_interval': 0, 02:26:13 INFO - 'suite': 'dromaeojs', 02:26:13 INFO - 'system_bits': '32', 02:26:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:26:13 INFO - 'title': 't-yosemite-r7-0182', 02:26:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:26:13 INFO - 'use_talos_json': True, 02:26:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:26:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:26:13 INFO - 'work_dir': 'build'} 02:26:13 INFO - ##### 02:26:13 INFO - ##### Running clobber step. 02:26:13 INFO - ##### 02:26:13 INFO - Running pre-action listener: _resource_record_pre_action 02:26:13 INFO - Running main action method: clobber 02:26:13 INFO - rmtree: /builds/slave/test/build 02:26:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:26:14 INFO - Running post-action listener: _resource_record_post_action 02:26:14 INFO - ##### 02:26:14 INFO - ##### Running read-buildbot-config step. 02:26:14 INFO - ##### 02:26:14 INFO - Running pre-action listener: _resource_record_pre_action 02:26:14 INFO - Running main action method: read_buildbot_config 02:26:14 INFO - Using buildbot properties: 02:26:14 INFO - { 02:26:14 INFO - "project": "", 02:26:14 INFO - "product": "firefox", 02:26:14 INFO - "script_repo_revision": "production", 02:26:14 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:26:14 INFO - "repository": "", 02:26:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:26:14 INFO - "buildid": "20160316004053", 02:26:14 INFO - "stage_platform": "macosx64", 02:26:14 INFO - "basedir": "/builds/slave/test", 02:26:14 INFO - "nightly_build": "True", 02:26:14 INFO - "buildnumber": 220, 02:26:14 INFO - "slavename": "t-yosemite-r7-0182", 02:26:14 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:26:14 INFO - "platform": "yosemite_r7", 02:26:14 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:26:14 INFO - "branch": "mozilla-aurora", 02:26:14 INFO - "repo_path": "releases/mozilla-aurora", 02:26:14 INFO - "revision": "bbdaba90d893f6fa09fdb287bf3d6227adda3457", 02:26:14 INFO - "pgo_build": "False", 02:26:14 INFO - "builduid": "38b89a7b29a94ad4bcde7995c0eeddef", 02:26:14 INFO - "slavebuilddir": "test" 02:26:14 INFO - } 02:26:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/EkHZqGmJTU6zgznUDxXoJg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 02:26:14 INFO - Running post-action listener: _resource_record_post_action 02:26:14 INFO - ##### 02:26:14 INFO - ##### Running download-and-extract step. 02:26:14 INFO - ##### 02:26:14 INFO - Running pre-action listener: _resource_record_pre_action 02:26:14 INFO - Running main action method: download_and_extract 02:26:14 INFO - mkdir: /builds/slave/test/build/tests 02:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:14 INFO - https://queue.taskcluster.net/v1/task/EkHZqGmJTU6zgznUDxXoJg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:26:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkHZqGmJTU6zgznUDxXoJg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:26:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkHZqGmJTU6zgznUDxXoJg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:26:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkHZqGmJTU6zgznUDxXoJg/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 02:26:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkHZqGmJTU6zgznUDxXoJg/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 02:26:17 INFO - Downloaded 1277 bytes. 02:26:17 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 02:26:17 INFO - Using the following test package requirements: 02:26:17 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:26:17 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:26:17 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 02:26:17 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:26:17 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 02:26:17 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:26:17 INFO - u'jsshell-mac.zip'], 02:26:17 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:26:17 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 02:26:17 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:26:17 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:26:17 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 02:26:17 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:26:17 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 02:26:17 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:26:17 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 02:26:17 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:26:17 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:26:17 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 02:26:17 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:26: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')]} 02:26:17 INFO - https://queue.taskcluster.net/v1/task/EkHZqGmJTU6zgznUDxXoJg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:26:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkHZqGmJTU6zgznUDxXoJg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:26:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkHZqGmJTU6zgznUDxXoJg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:26:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkHZqGmJTU6zgznUDxXoJg/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 02:26:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkHZqGmJTU6zgznUDxXoJg/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 02:26:18 INFO - Downloaded 17867313 bytes. 02:26:18 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'] 02:26:18 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 02:26:21 INFO - Return code: 0 02:26:21 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 02:26:21 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')]} 02:26:21 INFO - https://queue.taskcluster.net/v1/task/EkHZqGmJTU6zgznUDxXoJg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:26:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkHZqGmJTU6zgznUDxXoJg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:26:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkHZqGmJTU6zgznUDxXoJg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:26:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkHZqGmJTU6zgznUDxXoJg/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 02:26:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkHZqGmJTU6zgznUDxXoJg/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 02:26:22 INFO - Downloaded 17867313 bytes. 02:26:22 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'] 02:26:22 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 02:26:26 INFO - Return code: 0 02:26:26 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')]} 02:26:26 INFO - https://queue.taskcluster.net/v1/task/EkHZqGmJTU6zgznUDxXoJg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:26:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkHZqGmJTU6zgznUDxXoJg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:26:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkHZqGmJTU6zgznUDxXoJg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:26:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkHZqGmJTU6zgznUDxXoJg/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 02:26:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkHZqGmJTU6zgznUDxXoJg/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 02:26:28 INFO - Downloaded 10845161 bytes. 02:26:28 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'] 02:26:28 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 02:26:28 INFO - Return code: 0 02:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:28 INFO - https://queue.taskcluster.net/v1/task/EkHZqGmJTU6zgznUDxXoJg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:26:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkHZqGmJTU6zgznUDxXoJg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:26:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkHZqGmJTU6zgznUDxXoJg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:26:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkHZqGmJTU6zgznUDxXoJg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 02:26:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkHZqGmJTU6zgznUDxXoJg/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 02:26:31 INFO - Downloaded 115149103 bytes. 02:26:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EkHZqGmJTU6zgznUDxXoJg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:26:31 INFO - mkdir: /builds/slave/test/properties 02:26:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:26:31 INFO - Writing to file /builds/slave/test/properties/build_url 02:26:31 INFO - Contents: 02:26:31 INFO - build_url:https://queue.taskcluster.net/v1/task/EkHZqGmJTU6zgznUDxXoJg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:26:32 INFO - Running post-action listener: _resource_record_post_action 02:26:32 INFO - Running post-action listener: set_extra_try_arguments 02:26:32 INFO - ##### 02:26:32 INFO - ##### Running populate-webroot step. 02:26:32 INFO - ##### 02:26:32 INFO - Running pre-action listener: _resource_record_pre_action 02:26:32 INFO - Running main action method: populate_webroot 02:26:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:26:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:26:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:26:32 INFO - '--tppagecycles', 02:26:32 INFO - '7'], 02:26:32 INFO - 'tests': ['tsvgm']}}, 02:26:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:26:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:26:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:26:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:26:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:26:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:26:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:26:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:32 INFO - 'talos_options': ['--e10s'], 02:26:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:26:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:32 INFO - 'tests': ['damp', 'tps']}, 02:26:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:32 INFO - 'talos_options': ['--e10s'], 02:26:32 INFO - 'tests': ['damp', 'tps']}, 02:26:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:26:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:26:32 INFO - 'other': {'tests': ['a11yr', 02:26:32 INFO - 'ts_paint', 02:26:32 INFO - 'tpaint', 02:26:32 INFO - 'sessionrestore', 02:26:32 INFO - 'sessionrestore_no_auto_restore', 02:26:32 INFO - 'tabpaint']}, 02:26:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:26:32 INFO - 'tests': ['a11yr', 02:26:32 INFO - 'ts_paint', 02:26:32 INFO - 'tpaint', 02:26:32 INFO - 'sessionrestore', 02:26:32 INFO - 'sessionrestore_no_auto_restore', 02:26:32 INFO - 'tabpaint']}, 02:26:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:26:32 INFO - 'tests': ['a11yr', 02:26:32 INFO - 'ts_paint', 02:26:32 INFO - 'tpaint', 02:26:32 INFO - 'sessionrestore', 02:26:32 INFO - 'sessionrestore_no_auto_restore', 02:26:32 INFO - 'tabpaint']}, 02:26:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:26:32 INFO - 'tests': ['a11yr', 02:26:32 INFO - 'ts_paint', 02:26:32 INFO - 'tpaint', 02:26:32 INFO - 'sessionrestore', 02:26:32 INFO - 'sessionrestore_no_auto_restore', 02:26:32 INFO - 'tabpaint']}, 02:26:32 INFO - 'other_l64': {'tests': ['a11yr', 02:26:32 INFO - 'ts_paint', 02:26:32 INFO - 'tpaint', 02:26:32 INFO - 'sessionrestore', 02:26:32 INFO - 'sessionrestore_no_auto_restore', 02:26:32 INFO - 'tabpaint']}, 02:26:32 INFO - 'other_nol64': {'tests': ['a11yr', 02:26:32 INFO - 'ts_paint', 02:26:32 INFO - 'tpaint', 02:26:32 INFO - 'sessionrestore', 02:26:32 INFO - 'sessionrestore_no_auto_restore', 02:26:32 INFO - 'tabpaint']}, 02:26:32 INFO - 'svgr': {'tests': ['tsvgx', 02:26:32 INFO - 'tsvgr_opacity', 02:26:32 INFO - 'tart', 02:26:32 INFO - 'tscrollx', 02:26:32 INFO - 'cart']}, 02:26:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:26:32 INFO - 'tests': ['tsvgx', 02:26:32 INFO - 'tsvgr_opacity', 02:26:32 INFO - 'tart', 02:26:32 INFO - 'tscrollx', 02:26:32 INFO - 'cart']}, 02:26:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:32 INFO - 'tests': ['tp5o']}, 02:26:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:32 INFO - 'talos_options': ['--e10s'], 02:26:32 INFO - 'tests': ['tp5o']}, 02:26:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:32 INFO - 'talos_options': ['--xperf_path', 02:26:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:26:32 INFO - 'tests': ['tp5n']}, 02:26:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:32 INFO - 'talos_options': ['--e10s', 02:26:32 INFO - '--xperf_path', 02:26:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:26:32 INFO - 'tests': ['tp5n']}}, 02:26:32 INFO - 'talos.zip': {'path': '', 02:26:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:26:32 INFO - Running post-action listener: _resource_record_post_action 02:26:32 INFO - ##### 02:26:32 INFO - ##### Running create-virtualenv step. 02:26:32 INFO - ##### 02:26:32 INFO - Running pre-action listener: _resource_record_pre_action 02:26:32 INFO - Running main action method: create_virtualenv 02:26:32 INFO - Creating virtualenv /builds/slave/test/build/venv 02:26:32 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 02:26:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:26:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:26:32 INFO - Using real prefix '/tools/python27' 02:26:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:26:33 INFO - Installing distribute.............................................................................................................................................................................................done. 02:26:36 INFO - Installing pip.................done. 02:26:36 INFO - Return code: 0 02:26:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:26:36 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')]} 02:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:36 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')]} 02:26:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:36 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 0x106d1da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81d93530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc1d30>, '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 0x106a25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb8b20>, '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.QyiU4Yqo38/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.RLiyTZVeyQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 02:26:36 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 02:26:36 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 02:26:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QyiU4Yqo38/Render', 02:26:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:36 INFO - 'HOME': '/Users/cltbld', 02:26:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:36 INFO - 'LOGNAME': 'cltbld', 02:26:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:36 INFO - 'MOZ_NO_REMOTE': '1', 02:26:36 INFO - 'NO_EM_RESTART': '1', 02:26:36 INFO - 'PAGER': '/bin/cat', 02:26:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:36 INFO - 'PWD': '/builds/slave/test', 02:26:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:36 INFO - 'SHELL': '/bin/bash', 02:26:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RLiyTZVeyQ/Listeners', 02:26:36 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 02:26:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:36 INFO - 'USER': 'cltbld', 02:26:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:36 INFO - 'XPC_FLAGS': '0x0', 02:26:36 INFO - 'XPC_SERVICE_NAME': '0', 02:26:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:36 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 02:26:36 INFO - Cleaning up... 02:26:36 INFO - Return code: 0 02:26:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:26:36 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')]} 02:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:36 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')]} 02:26:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:36 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 0x106d1da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81d93530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc1d30>, '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 0x106a25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb8b20>, '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.QyiU4Yqo38/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.RLiyTZVeyQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 02:26:36 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 02:26:36 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 02:26:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QyiU4Yqo38/Render', 02:26:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:36 INFO - 'HOME': '/Users/cltbld', 02:26:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:36 INFO - 'LOGNAME': 'cltbld', 02:26:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:36 INFO - 'MOZ_NO_REMOTE': '1', 02:26:36 INFO - 'NO_EM_RESTART': '1', 02:26:36 INFO - 'PAGER': '/bin/cat', 02:26:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:36 INFO - 'PWD': '/builds/slave/test', 02:26:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:36 INFO - 'SHELL': '/bin/bash', 02:26:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RLiyTZVeyQ/Listeners', 02:26:36 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 02:26:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:36 INFO - 'USER': 'cltbld', 02:26:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:36 INFO - 'XPC_FLAGS': '0x0', 02:26:36 INFO - 'XPC_SERVICE_NAME': '0', 02:26:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:36 INFO - Downloading/unpacking psutil>=0.7.1 02:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:26:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:26:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:26:40 INFO - Installing collected packages: psutil 02:26:40 INFO - Running setup.py install for psutil 02:26:40 INFO - building 'psutil._psutil_osx' extension 02:26:40 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 02:26:40 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 02:26:40 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 02:26:40 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 02:26:41 INFO - building 'psutil._psutil_posix' extension 02:26:41 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 02:26:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:26:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:26:41 INFO - ^ 02:26:41 INFO - 1 warning generated. 02:26:41 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 02:26:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:26:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:26:41 INFO - Successfully installed psutil 02:26:41 INFO - Cleaning up... 02:26:41 INFO - Return code: 0 02:26:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:41 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 0x106d1da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81d93530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc1d30>, '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 0x106a25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb8b20>, '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.QyiU4Yqo38/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.RLiyTZVeyQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 02:26:41 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 02:26:41 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 02:26:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QyiU4Yqo38/Render', 02:26:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:41 INFO - 'HOME': '/Users/cltbld', 02:26:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:41 INFO - 'LOGNAME': 'cltbld', 02:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:41 INFO - 'MOZ_NO_REMOTE': '1', 02:26:41 INFO - 'NO_EM_RESTART': '1', 02:26:41 INFO - 'PAGER': '/bin/cat', 02:26:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:41 INFO - 'PWD': '/builds/slave/test', 02:26:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:41 INFO - 'SHELL': '/bin/bash', 02:26:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RLiyTZVeyQ/Listeners', 02:26:41 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 02:26:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:41 INFO - 'USER': 'cltbld', 02:26:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:41 INFO - 'XPC_FLAGS': '0x0', 02:26:41 INFO - 'XPC_SERVICE_NAME': '0', 02:26:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:26: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 02:26: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 02:26: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 02:26: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 02:26: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 02:26: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 02:26:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:26:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:26:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:26:44 INFO - Installing collected packages: mozsystemmonitor 02:26:44 INFO - Running setup.py install for mozsystemmonitor 02:26:44 INFO - Successfully installed mozsystemmonitor 02:26:44 INFO - Cleaning up... 02:26:44 INFO - Return code: 0 02:26:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106d1da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81d93530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc1d30>, '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 0x106a25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb8b20>, '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.QyiU4Yqo38/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.RLiyTZVeyQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 02:26:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:26:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:26:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QyiU4Yqo38/Render', 02:26:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:44 INFO - 'HOME': '/Users/cltbld', 02:26:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:44 INFO - 'LOGNAME': 'cltbld', 02:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:44 INFO - 'MOZ_NO_REMOTE': '1', 02:26:44 INFO - 'NO_EM_RESTART': '1', 02:26:44 INFO - 'PAGER': '/bin/cat', 02:26:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:44 INFO - 'PWD': '/builds/slave/test', 02:26:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:44 INFO - 'SHELL': '/bin/bash', 02:26:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RLiyTZVeyQ/Listeners', 02:26:44 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 02:26:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:44 INFO - 'USER': 'cltbld', 02:26:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:44 INFO - 'XPC_FLAGS': '0x0', 02:26:44 INFO - 'XPC_SERVICE_NAME': '0', 02:26:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:44 INFO - Downloading/unpacking blobuploader==1.2.4 02:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:46 INFO - Downloading blobuploader-1.2.4.tar.gz 02:26:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:26:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:26:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:48 INFO - Downloading docopt-0.6.1.tar.gz 02:26:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:26:48 INFO - Installing collected packages: blobuploader, requests, docopt 02:26:48 INFO - Running setup.py install for blobuploader 02:26:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:26:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:26:48 INFO - Running setup.py install for requests 02:26:48 INFO - Running setup.py install for docopt 02:26:49 INFO - Successfully installed blobuploader requests docopt 02:26:49 INFO - Cleaning up... 02:26:49 INFO - Return code: 0 02:26:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:49 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 0x106d1da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81d93530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc1d30>, '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 0x106a25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb8b20>, '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.QyiU4Yqo38/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.RLiyTZVeyQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 02:26:49 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 02:26:49 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 02:26:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QyiU4Yqo38/Render', 02:26:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:49 INFO - 'HOME': '/Users/cltbld', 02:26:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:49 INFO - 'LOGNAME': 'cltbld', 02:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:49 INFO - 'MOZ_NO_REMOTE': '1', 02:26:49 INFO - 'NO_EM_RESTART': '1', 02:26:49 INFO - 'PAGER': '/bin/cat', 02:26:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:49 INFO - 'PWD': '/builds/slave/test', 02:26:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:49 INFO - 'SHELL': '/bin/bash', 02:26:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RLiyTZVeyQ/Listeners', 02:26:49 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 02:26:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:49 INFO - 'USER': 'cltbld', 02:26:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:49 INFO - 'XPC_FLAGS': '0x0', 02:26:49 INFO - 'XPC_SERVICE_NAME': '0', 02:26:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:26:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-20jkO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:26:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-32RPQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:26:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-jks00y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:26:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-l5VnYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:26:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-4mwbEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:26:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-rhhmLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:26:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-P4nneZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:26:50 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-pCEbDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:26:50 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-RxHpD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:26:50 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-wM2m40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:26:50 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-dOo08c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:26:50 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-tN28zJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:26:50 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-5WFe7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:26:50 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-rLKLhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:50 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-yXMSa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:26:50 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-1MR8_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:26:51 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-etoVbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:26:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:26:51 INFO - Running setup.py install for manifestparser 02:26:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:26:51 INFO - Running setup.py install for mozcrash 02:26:51 INFO - Running setup.py install for mozdebug 02:26:51 INFO - Running setup.py install for mozdevice 02:26:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:26:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:26:51 INFO - Running setup.py install for mozfile 02:26:51 INFO - Running setup.py install for mozhttpd 02:26:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:26:52 INFO - Running setup.py install for mozinfo 02:26:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:26:52 INFO - Running setup.py install for mozInstall 02:26:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:26:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:26:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:26:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:26:52 INFO - Running setup.py install for mozleak 02:26:52 INFO - Running setup.py install for mozlog 02:26:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:26:52 INFO - Running setup.py install for moznetwork 02:26:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:26:52 INFO - Running setup.py install for mozprocess 02:26:52 INFO - Running setup.py install for mozprofile 02:26:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:26:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:26:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:26:53 INFO - Running setup.py install for mozrunner 02:26:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:26:53 INFO - Running setup.py install for mozscreenshot 02:26:53 INFO - Running setup.py install for moztest 02:26:53 INFO - Running setup.py install for mozversion 02:26:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:26:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:26:53 INFO - Cleaning up... 02:26:53 INFO - Return code: 0 02:26:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:53 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 0x106d1da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81d93530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc1d30>, '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 0x106a25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb8b20>, '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.QyiU4Yqo38/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.RLiyTZVeyQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 02:26:53 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 02:26:53 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 02:26:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QyiU4Yqo38/Render', 02:26:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:53 INFO - 'HOME': '/Users/cltbld', 02:26:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:53 INFO - 'LOGNAME': 'cltbld', 02:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:53 INFO - 'MOZ_NO_REMOTE': '1', 02:26:53 INFO - 'NO_EM_RESTART': '1', 02:26:53 INFO - 'PAGER': '/bin/cat', 02:26:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:53 INFO - 'PWD': '/builds/slave/test', 02:26:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:53 INFO - 'SHELL': '/bin/bash', 02:26:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RLiyTZVeyQ/Listeners', 02:26:53 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 02:26:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:53 INFO - 'USER': 'cltbld', 02:26:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:53 INFO - 'XPC_FLAGS': '0x0', 02:26:53 INFO - 'XPC_SERVICE_NAME': '0', 02:26:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:26:54 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-fiqR__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:26:54 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)) 02:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:26:54 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-LUdavb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:26:54 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)) 02:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:26:54 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-5Ciwxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:26:54 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)) 02:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:26:54 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-x7ofII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:26:54 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)) 02:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:26:54 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-VVdKtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:26:54 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)) 02:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:26:54 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-plc_Ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:26:54 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)) 02:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:26:54 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-rIsQyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:26:54 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)) 02:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:26:54 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-OJQHgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:26:54 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)) 02:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:26:54 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-XtTvU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:26:54 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)) 02:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:26:54 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-T_8T79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:26:55 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)) 02:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:26:55 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-dYITQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:26:55 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)) 02:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:26:55 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-EFX0hQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:26:55 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)) 02:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:26:55 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-dD7IUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:26:55 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)) 02:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:26:55 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-CoDDkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:26:55 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)) 02:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:55 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-EFvDbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:55 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)) 02:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:26:55 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-TIUUce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:26:55 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)) 02:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:26:55 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-EXR1Q4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:26:55 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)) 02:26:55 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)) 02:26:55 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)) 02:26:55 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)) 02:26:55 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)) 02:26:55 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)) 02:26:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:58 INFO - Downloading blessings-1.6.tar.gz 02:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:26:58 INFO - Installing collected packages: blessings 02:26:58 INFO - Running setup.py install for blessings 02:26:58 INFO - Successfully installed blessings 02:26:58 INFO - Cleaning up... 02:26:58 INFO - Return code: 0 02:26:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:26:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:26:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:26:58 INFO - Reading from file tmpfile_stdout 02:26:58 INFO - Current package versions: 02:26:58 INFO - blessings == 1.6 02:26:58 INFO - blobuploader == 1.2.4 02:26:58 INFO - docopt == 0.6.1 02:26:58 INFO - manifestparser == 1.1 02:26:58 INFO - mozInstall == 1.12 02:26:58 INFO - mozcrash == 0.17 02:26:58 INFO - mozdebug == 0.1 02:26:58 INFO - mozdevice == 0.48 02:26:58 INFO - mozfile == 1.2 02:26:58 INFO - mozhttpd == 0.7 02:26:58 INFO - mozinfo == 0.9 02:26:58 INFO - mozleak == 0.1 02:26:58 INFO - mozlog == 3.1 02:26:58 INFO - moznetwork == 0.27 02:26:58 INFO - mozprocess == 0.22 02:26:58 INFO - mozprofile == 0.28 02:26:58 INFO - mozrunner == 6.11 02:26:58 INFO - mozscreenshot == 0.1 02:26:58 INFO - mozsystemmonitor == 0.0 02:26:58 INFO - moztest == 0.7 02:26:58 INFO - mozversion == 1.4 02:26:58 INFO - psutil == 3.1.1 02:26:58 INFO - requests == 1.2.3 02:26:58 INFO - wsgiref == 0.1.2 02:26:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:58 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 0x106d1da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81d93530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc1d30>, '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 0x106a25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb8b20>, '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.QyiU4Yqo38/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.RLiyTZVeyQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 02:26:58 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 02:26:58 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 02:26:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QyiU4Yqo38/Render', 02:26:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:58 INFO - 'HOME': '/Users/cltbld', 02:26:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:58 INFO - 'LOGNAME': 'cltbld', 02:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:58 INFO - 'MOZ_NO_REMOTE': '1', 02:26:58 INFO - 'NO_EM_RESTART': '1', 02:26:58 INFO - 'PAGER': '/bin/cat', 02:26:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:58 INFO - 'PWD': '/builds/slave/test', 02:26:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:58 INFO - 'SHELL': '/bin/bash', 02:26:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RLiyTZVeyQ/Listeners', 02:26:58 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 02:26:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:58 INFO - 'USER': 'cltbld', 02:26:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:58 INFO - 'XPC_FLAGS': '0x0', 02:26:58 INFO - 'XPC_SERVICE_NAME': '0', 02:26:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:59 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)) 02:26:59 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)) 02:26:59 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)) 02:26:59 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)) 02:26:59 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)) 02:26:59 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)) 02:26:59 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)) 02:26:59 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)) 02:26:59 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)) 02:26:59 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)) 02:26:59 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)) 02:26:59 INFO - Cleaning up... 02:26:59 INFO - Return code: 0 02:26:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:26:59 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')]} 02:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:59 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')]} 02:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:59 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 0x106d1da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81d93530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc1d30>, '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 0x106a25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb8b20>, '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.QyiU4Yqo38/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.RLiyTZVeyQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 02:26:59 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 02:26:59 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 02:26:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QyiU4Yqo38/Render', 02:26:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:59 INFO - 'HOME': '/Users/cltbld', 02:26:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:59 INFO - 'LOGNAME': 'cltbld', 02:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:59 INFO - 'MOZ_NO_REMOTE': '1', 02:26:59 INFO - 'NO_EM_RESTART': '1', 02:26:59 INFO - 'PAGER': '/bin/cat', 02:26:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:59 INFO - 'PWD': '/builds/slave/test', 02:26:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:59 INFO - 'SHELL': '/bin/bash', 02:26:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RLiyTZVeyQ/Listeners', 02:26:59 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 02:26:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:59 INFO - 'USER': 'cltbld', 02:26:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:59 INFO - 'XPC_FLAGS': '0x0', 02:26:59 INFO - 'XPC_SERVICE_NAME': '0', 02:26:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:59 INFO - Downloading/unpacking jsonschema 02:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:27:01 INFO - Downloading/unpacking functools32 (from jsonschema) 02:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:02 INFO - Downloading functools32-3.2.3-2.tar.gz 02:27:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:27:02 INFO - warning: no files found matching '*.txt' 02:27:02 INFO - no previously-included directories found matching 'build' 02:27:02 INFO - no previously-included directories found matching 'dist' 02:27:02 INFO - no previously-included directories found matching '.git*' 02:27:02 INFO - Installing collected packages: jsonschema, functools32 02:27:02 INFO - Running setup.py install for functools32 02:27:02 INFO - warning: no files found matching '*.txt' 02:27:02 INFO - no previously-included directories found matching 'build' 02:27:02 INFO - no previously-included directories found matching 'dist' 02:27:02 INFO - no previously-included directories found matching '.git*' 02:27:02 INFO - Successfully installed jsonschema functools32 02:27:02 INFO - Cleaning up... 02:27:02 INFO - Return code: 0 02:27:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:27: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')]} 02:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27: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')]} 02:27:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:02 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 0x106d1da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81d93530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc1d30>, '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 0x106a25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb8b20>, '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.QyiU4Yqo38/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.RLiyTZVeyQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 02:27:02 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 02:27:02 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 02:27:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QyiU4Yqo38/Render', 02:27:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:02 INFO - 'HOME': '/Users/cltbld', 02:27:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:02 INFO - 'LOGNAME': 'cltbld', 02:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:02 INFO - 'MOZ_NO_REMOTE': '1', 02:27:02 INFO - 'NO_EM_RESTART': '1', 02:27:02 INFO - 'PAGER': '/bin/cat', 02:27:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:02 INFO - 'PWD': '/builds/slave/test', 02:27:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:02 INFO - 'SHELL': '/bin/bash', 02:27:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RLiyTZVeyQ/Listeners', 02:27:02 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 02:27:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:02 INFO - 'USER': 'cltbld', 02:27:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:02 INFO - 'XPC_FLAGS': '0x0', 02:27:02 INFO - 'XPC_SERVICE_NAME': '0', 02:27:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:02 INFO - Downloading/unpacking flake8 02:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:27:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:27:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:27:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:27:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:27:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:27:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:27:06 INFO - no previously-included directories found matching 'docs/_build' 02:27:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:27:06 INFO - Running setup.py install for pep8 02:27:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:27:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:27:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:27:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:27:06 INFO - no previously-included directories found matching 'docs/_build' 02:27:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:27:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:27:06 INFO - Cleaning up... 02:27:06 INFO - Return code: 0 02:27:06 INFO - Running post-action listener: _resource_record_post_action 02:27:06 INFO - Running post-action listener: _start_resource_monitoring 02:27:06 INFO - Starting resource monitoring. 02:27:06 INFO - ##### 02:27:06 INFO - ##### Running install step. 02:27:06 INFO - ##### 02:27:06 INFO - Running pre-action listener: _resource_record_pre_action 02:27:06 INFO - Running main action method: install 02:27:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:27:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:27:06 INFO - Reading from file tmpfile_stdout 02:27:06 INFO - Detecting whether we're running mozinstall >=1.0... 02:27:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:27:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:27:07 INFO - Reading from file tmpfile_stdout 02:27:07 INFO - Output received: 02:27:07 INFO - Usage: mozinstall [options] installer 02:27:07 INFO - Options: 02:27:07 INFO - -h, --help show this help message and exit 02:27:07 INFO - -d DEST, --destination=DEST 02:27:07 INFO - Directory to install application into. [default: 02:27:07 INFO - "/builds/slave/test"] 02:27:07 INFO - --app=APP Application being installed. [default: firefox] 02:27:07 INFO - mkdir: /builds/slave/test/build/application 02:27:07 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'] 02:27:07 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 02:27:38 INFO - Reading from file tmpfile_stdout 02:27:38 INFO - Output received: 02:27:38 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:27:38 INFO - Running post-action listener: _resource_record_post_action 02:27:38 INFO - ##### 02:27:38 INFO - ##### Running run-tests step. 02:27:38 INFO - ##### 02:27:38 INFO - Running pre-action listener: _resource_record_pre_action 02:27:38 INFO - Running main action method: run_tests 02:27:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:27:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:27:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:27:38 INFO - 2016-03-16 02:27:38.883 screenresolution[1646:7911] starting screenresolution argv=screenresolution get 02:27:38 INFO - 2016-03-16 02:27:38.885 screenresolution[1646:7911] Display 0: 1600x1200x32@60 02:27:38 INFO - 2016-03-16 02:27:38.891 screenresolution[1647:7913] starting screenresolution argv=screenresolution list 02:27:38 INFO - Available Modes on Display 0 02:27:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:27:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:27:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:27:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:27:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:27:39 INFO - Intel Iris: 02:27:39 INFO - Chipset Model: Intel Iris 02:27:39 INFO - Type: GPU 02:27:39 INFO - Bus: Built-In 02:27:39 INFO - VRAM (Dynamic, Max): 1536 MB 02:27:39 INFO - Vendor: Intel (0x8086) 02:27:39 INFO - Device ID: 0x0a2e 02:27:39 INFO - Revision ID: 0x0009 02:27:39 INFO - Displays: 02:27:39 INFO - Display: 02:27:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:27:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:27:39 INFO - Display Serial Number: 1600x1200 60 02:27:39 INFO - Main Display: Yes 02:27:39 INFO - Mirror: Off 02:27:39 INFO - Online: Yes 02:27:39 INFO - Rotation: Supported 02:27:39 INFO - Return code: 0 02:27:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:27:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:27:39 INFO - Python 2.7.3 02:27:39 INFO - Return code: 0 02:27:39 INFO - grabbing minidump binary from tooltool 02:27:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:27:39 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 0x106bc1d30>, '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 0x106a25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:27:39 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 02:27:39 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 02:27:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:27:39 INFO - Return code: 0 02:27:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:27:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:27:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:27:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:27:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:27:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:27:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:27:40 INFO - Return code: 0 02:27:40 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/EkHZqGmJTU6zgznUDxXoJg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0182', '--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 02:27:40 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/EkHZqGmJTU6zgznUDxXoJg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0182 --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 02:27:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QyiU4Yqo38/Render', 02:27:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:40 INFO - 'HOME': '/Users/cltbld', 02:27:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:40 INFO - 'LOGNAME': 'cltbld', 02:27:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:27:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:27:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:40 INFO - 'MOZ_NO_REMOTE': '1', 02:27:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:27:40 INFO - 'NO_EM_RESTART': '1', 02:27:40 INFO - 'PAGER': '/bin/cat', 02:27:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:40 INFO - 'PWD': '/builds/slave/test', 02:27:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:27:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:40 INFO - 'SHELL': '/bin/bash', 02:27:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RLiyTZVeyQ/Listeners', 02:27:40 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 02:27:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:40 INFO - 'USER': 'cltbld', 02:27:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:40 INFO - 'XPC_FLAGS': '0x0', 02:27:40 INFO - 'XPC_SERVICE_NAME': '0', 02:27:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:40 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/EkHZqGmJTU6zgznUDxXoJg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0182', '--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 02:27:40 INFO - mozversion application_buildid: 20160316004053 02:27:40 INFO - mozversion application_changeset: bbdaba90d893f6fa09fdb287bf3d6227adda3457 02:27:40 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:27:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:27:40 INFO - mozversion application_name: Firefox 02:27:40 INFO - mozversion application_remotingname: firefox-dev 02:27:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:27:40 INFO - mozversion application_vendor: Mozilla 02:27:40 INFO - mozversion application_version: 47.0a2 02:27:40 INFO - mozversion platform_buildid: 20160316004053 02:27:40 INFO - mozversion platform_changeset: bbdaba90d893f6fa09fdb287bf3d6227adda3457 02:27:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:27:40 INFO - mozversion platform_version: 47.0a2 02:27:40 INFO - using testdate: 1458120460 02:27:40 INFO - actual date: 1458120460 02:27:40 INFO - starting webserver on 'localhost:49272' 02:27:40 INFO - SUITE-START | Running 2 tests 02:27:40 INFO - TEST-START | dromaeo_css 02:27:40 INFO - operating with platform_type : mac_ 02:27:40 INFO - Initialising browser for dromaeo_css test... 02:27:40 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmpgtpZdt/profile http://localhost:49272/getInfo.html) 02:27:43 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 02:27:43 INFO - PROCESS | 1665 | colorDepth:24 02:27:43 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 02:27:43 INFO - PROCESS | 1665 | __metrics 02:27:43 INFO - PROCESS | 1665 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:27:43 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:27:43 INFO - TEST-INFO | 1665: exit 0 02:27:43 INFO - Browser initialized. 02:27:43 INFO - Running cycle 1/1 for dromaeo_css test... 02:27:43 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmpgtpZdt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:27:55 INFO - PROCESS | 1669 | RSS: Main: 210583552 02:27:55 INFO - PROCESS | 1669 | 02:28:47 INFO - PROCESS | 1669 | 1458120527195 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] 02:30:57 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 02:30:58 INFO - PROCESS | 1669 | RSS: Main: 327131136 02:30:58 INFO - PROCESS | 1669 | 02:34:01 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 02:34:01 INFO - PROCESS | 1669 | RSS: Main: 339206144 02:34:01 INFO - PROCESS | 1669 | 02:37:03 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 02:37:04 INFO - PROCESS | 1669 | RSS: Main: 347881472 02:37:04 INFO - PROCESS | 1669 | 02:40:06 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 02:40:06 INFO - PROCESS | 1669 | RSS: Main: 308428800 02:40:06 INFO - PROCESS | 1669 | 02:43:10 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 02:43:10 INFO - PROCESS | 1669 | RSS: Main: 308248576 02:43:10 INFO - PROCESS | 1669 | 02:46:13 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 02:46:13 INFO - PROCESS | 1669 | RSS: Main: 352743424 02:46:13 INFO - PROCESS | 1669 | 02:46:13 INFO - PROCESS | 1669 | __start_tp_report 02:46:13 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 02:46:13 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 02:46:13 INFO - PROCESS | 1669 | |i|pagename|runs| 02:46:13 INFO - PROCESS | 1669 | |0;dojo.html;3450.3271861986914;3506.6148871195896;3522.0842580928966;3544.2379888324012;3598.0824889653136;5814.563907706923;5836.912446313303;5837.182794408775;5861.76552937883;5879.823605291843;5842.2989241291;5858.2677165354335;5870.501007414364;5873.383294754053;5875.559333050028;5166.380034395877;5237.3715154181555;5278.340207474056;5313.654612450178;5361.383440904287;5333.120035194188;5334.546563542103;5361.758720857571;5363.383210930734;5363.463653634625;5256.92114618281;5333.546648534879;5360.9463905361035;5362.088444964346;5373.113436283009;4698.506656801055;5327.174287985368;5361.383440904268;5366.70483123428;5404.891902161974;4253.532111467736;5195.168772996302;5254.842354729364;5265.447128051576;5270.420253772082;5691.117876729114;5695.971520142414;5749.367569567345;5752.453516915886;5762.279715035621;5214.5306922376785;6156.922538555735;6267.4045965633195;6270.623762574214;6289.937100628981;6222.097795819626;6239.970404883189;6251.624902505864;6272.717727702265;6297.968510157466;5933.495652869511;5951.821445356646;5969.462748352713;5973.940260597426;5978.701064946736;6226.844328891814;6306.085617585516;6384.106225128486;6388.776392826228;6407.7436902524305;6219.502439804804;6245.437910587978;6259.217597800275;6259.593126446766;6280.120783090371;6271.4669253114;6276.089966954857;6285.43431091204;6304.810855674337;6309.242890853127;6148.016317389286;6166.630002199792;6181.96909015452;6241.407066328691;6267.874642507124;5262.7631756571045;6215.689215539205;6266.24805023391;6280.717367718464;6286.245650521967;4979.551840334388;4992.825251116194;4994.600431965434;5006.123928312531;5007.524285192901;3831.501904752364;4330.458692663417;4392.516823149451;4500.189965806121;4536.183486972377;5851.1515830205235;5852.122181672698;5865.266841644794;5866.120081987736;5891.41085891416;6239.532035097386;6256.874862502816;6259.7496100156395;6263.404976527223;6285.245770507477;5787.334456537468;5832;5847.093700476433;5918.704064796743;5957.463828255478;5441.646292990943;5471.945280547144;5476.397596264408;5480.91778623321;5482;6401.775937842246;6459.321771214143;6461.709223084972;6466.159399278064;6472.3204063573585;6179.969100154471;6243.250809902659;6244.219472565929;6286.685665716787;6295.5907865988565;6442.452391546583;6445.355464453517;6449.451796597342;6458.67706614658;6466.547341686037;6192.349803270772;6192.783252586138;6230.283517395557;6247.937520624736;6277.74889004453;6191.102290167991;6195.884740746709;6247.875042499216;6276.089966954674;6287.779927702509;4882.975585122052;6144.2319710036245;6234.688265586612;6253.1245625613365;6260.060990851409;6088.786892458743;6264.467520260829;6265.4361107500545;6283;6288.5598008138995;6040.6677632730625;6142.9078563820685;6152.507799376129;6154;6155.722992465439;6218.875622487615;6237.5009999200865;6246.531510136667;6263.561550691408;6263.592866463665;5897.734601943009;6096;6102.267727872683;6120.816375508742;6134.04922237054 02:46:13 INFO - PROCESS | 1669 | |1;ext.html;481.7013451659971;605.4490413723513;614.9631022138675;621.847647326405;656.47154040997;26157.2152835415;32373.21947292898;40416.59583404169;40675.59324406755;40796.572119975805;44202.778986105026;44754.32868506975;44769;44779;44832.10335793282;9730.464824434654;9953.253505987044;9957.701268961942;9958.601655933753;9967.302288839785;9682.080202380797;9770.462624555646;9807.754806129833;9848.556814943344;9855;8918.73243802687;9642.2768292378;9877.60489580416;9962.950185249063;9983.001699829994;9865.210783137367;9941.353812002233;9944.303898727092;9947.1544918682;9949.950250248774;9812.607495700235;9943.5028248588;9951.303408761389;9961.40231586107;9962.601495940155;42094.84288678361;42254.78872605648;42480.57519424828;42502.78748606268;42546.78726606378;3292.539044533767;3411.727061835047;3427.160345715291;3529.1353618363664;3796.1648437343742;29714.554281685792;29860;29915.102546923627;30275.394492110256;30396.848015760002;2772.5841123831383;2788.8326700398043;2802.5936239245193;2823.745862872351;2886.740193382606;517165;521129;524464;525177;527048;70527;72023.6398818013;72653.636731816;72765.6361718188;72771;77769.611151945;78718.81921771177;79015;79135.8129628056;79142;18335.991520466236;18497.722534162;18509.167087481095;18524.07379631013;18535.907320463582;13720.382582783799;13775.173489590657;13812.792808107886;13816.447342106405;13823.170609763447;22620.660690089662;22702.432439189153;22718.864056797094;22974.770252297596;22990.42523936915;8388.238469921385;9713.22294216461;9781.755456113511;9872.901270987342;9904.504774761233;982.7887004294112;998.2612866478753;1067.8771941226703;1072.2387105155271;1137.5790957345835;25113.748862511507;30583.08250752481;30653.080407587808;31176.376472470878;31197.376052478823;1036.5646428500047;1153.313778301909;1175.2948231061466;1207.7463732616072;1246.7755803955374;15989.600259993593;16323.26545305464;16383.344666213456;16531.586710332336;16570;455850;459266;460850;461160;461798;60367.69816150891;60977;60981.695091525144;60981.78036439335;61135;1450.1299220467845;1510.5996910818642;1574.944876929302;1585.6907902959042;1592.076595574564;29381.265468362606;30524.542131868486;30719;30980.22549436192;31061.762387893406;41001.97495062528;50175.74912125416;50527.24209136792;50547;50682.73293167553;378545;379747;380691;381702;381741;30419.935302264315;34741.47887781736;34800.47799283063;35155.472667910515;35672.64327356797;42795.358069629605;45048.324275135245;49058.264126038855;50300;50451.73870653263;36724.81637591795;36730.26539469249;37152.628473715995;37479.81260093682;38214.80892595519;37148.81425592963;37193.81403092967;37535.43696844604;37880.810595946845;37884.62115378921;36318;36794.816025919696;37370;37917.62082379141;37991.810040950724;33728;33861.49207761935;34754.30491390209;34824.47763283603;35472.822635887685;24585;25601.871990639927;25749.613755793303;25988;26448.8677556611 02:46:13 INFO - PROCESS | 1669 | |2;jquery.html;335.76047761431255;360.7510817535901;371.53929127881435;382.64031810098504;393.6181903553552;17215.569610759707;20072.59854802903;20773.792262077375;20974.32205423566;21109.472263193427;20149.891755953417;20539.691904621443;21160;21195.682064769004;22236.110555577758;5805.15825205346;5976.611520251192;5978.252718410199;6018.548608854331;6030.969845150768;4372.5627437256335;4398.208322501949;4571.679982401233;6441.516886233528;6463.192100987377;6363.459105975998;6392.360763923593;6396.808095757112;6399.168108145957;6414.711337989778;5739.655620662774;6005.789797357115;6015.218021657157;6019.5184385249295;6377.681115944208;4012.6789856811383;4650.4186976627925;5726.284214473191;5751.4536119068625;5765.990951583498;13509.662258443519;13737.587872363845;13951;13980.440782368692;14391.280435978158;2138.5402138540135;2170.858894171874;2351.5179388225374;2372.79831214347;2805.9017934372405;9942.850857237147;10025.949870250603;10162.745931351701;10572.207084468695;10613.097886679641;1779.6084861330487;1800.4238643634042;1807.1145138881852;1845.0866820923595;1848.02978436322;80861;113740.43129784298;115244;117968;119671.20493192523;9470.195033422098;11977.341246231366;11994.700132496757;12032.037437005194;12161.5135394585;14505.202213878127;14537.418503259963;14550.4907328243;14569.490067847786;14575;8755.299576033902;9024.729258122135;9026.007139214682;9085.727428177166;9123.543822808833;9245.306602004743;9280.72157835266;9282.675106371245;9359.204467620328;9362.391444556082;4620.653450991189;4701;4708.929366059512;4709.434867815816;4737.242041273448;1946.3966170487195;1975.2494052260336;1991.412533302679;1993.1130646862298;1998.6302534031252;913.5386629751932;992.2905122837207;992.503748125937;1023.8873723890515;1096.5065720425841;20654.17383304681;21097.367078987656;21273.468163295733;21309.573808523743;21339.35981920514;972.397113789455;1029.893867041901;1034.9016843399866;1082.1072615092423;1085.2132204152085;9252.213561847184;10894.727631809268;11322.264052836705;11476.311421314747;11510.539578416938;275384;626422.8678856577;658352;658479.4152058514;673589;99051.50474247582;109784.9999999984;116942;118339.40830295793;122798;1028.1106842581114;1032.8037672842136;1055.1400608504046;1056.6248981611418;1056.6777132974516;15538.378464861278;17930.372436964644;18108.547286317946;18181.272749089887;19098.7135192975;53417.46582534125;54606.72696636491;54949.72525137509;55714.88570228654;55783;74670.87993680208;76916.61541692256;77628.22371776435;79484;80043.3991320182;8074.111847696631;8235.13531079228;8270.297024752723;8310.127436619068;8603.956980215058;9589.664361747306;10571.471426428801;11449.59926402572;13834.031617786659;14092.084014539023;10530.526126324181;11629.127815414047;11696.70758231051;11754.412279385826;12142.053832504294;7521.168522332676;8158;11678.299302041905;11769.882301176878;12050.819237711266;12029.398530073637;12057.138003567195;12223.388830558615;12377.195482293622;12391.318477483825;8521.701740439055;8645.827083458422;8658.350623703373;8722.302215822845;8771.122887711177;8761.211490965843;11253.88746112561;11980.221285616408;12074.335911524951;12134.696632584257 02:46:13 INFO - PROCESS | 1669 | |3;mootools.html;1418.5744276716985;1472.5655931500207;1625.544847442716;1882.9905850470745;2058.588282343531;8103.432759706823;8727.214550690436;8894.421862578927;8909.376343655947;8935.463872167675;8651.04838467768;8894.510801905893;8901.465912045265;8901.866472002925;8903.688370907019;2537.89848406064;2563.6410902473667;2566.974330256692;2567.82025258232;2568.743125687435;2506.624006399046;2565.3586603349163;2567.101514469939;2569.7301783312764;2572.5626643470655;2388.904443822245;2493.5386953413586;2512.309114993373;2512.949741005179;2513.28371414147;2545.0456078970387;2569.0366112707734;2572.794176465878;2576.703679076902;2579.445419234855;2529.886155123024;2565.1534993452115;2572.5626643470655;2573.6396904433395;2578.7292334304816;8945.64217431302;9018.008019117891;9025.05236950124;9027.954860225656;9043.502607356593;5279.392869819982;5399.649022813504;5415.83752487426;5451.3458384993655;5453.972730136364;3614.150674591469;3712.257548490286;3747.625237476258;3766.8681596144;3776.8300426480873;919.4161707315835;1046.2414749306768;1070.2133931560297;1080.6109800471825;1099.8240281554913;12348.38258087092;12370.257784532867;12371.876281237252;12379.566715164927;12393.442295096742;4853.02939412119;4934.777934992934;4992.350994370709;4993.101241776442;5008.424031236382;10332.741681457874;10346.430946297874;10350.948245258876;10351.948240258902;10354.585816567253;5583.274174357308;5585.916211256835;5591.245181900473;5601.775928962796;5628.352739435018;4540.228161212602;4615.192341340252;4860.8784780380065;4985.925211121836;5111.258867464197;3974.5627980922077;4045.110075783382;4051.230266249403;4079.3676980068135;4103.671706263492;1334.8798608125314;1338.3040818774182;1339.430741934674;1357.5248662967883;1368.609946165338;1051.952662130206;1087.1737479515466;1186.9406529673481;1353.1272329347712;1454.2365258239297;8143.511389316542;8151.836963260702;8253.298469630148;8289;8291.461055031403;1038.5793753529833;1232.039009572535;1232.4761976160096;1255.0461649146714;1267.6070418170398;6258.405451482102;6295.905561416583;6371.617702937839;6374.872502549923;6376.872462550723;10458.26792124544;10893.237473376947;10912.836307455394;10984.340939543654;10996.28524145928;10575.153987680967;10637.840432393521;10800.891991080145;10868.347899126078;10882.347059176474;8377.329813614897;8488.702895398756;8523.190296921783;8545.529995850164;8545.572721363907;7967.681292748457;7974.082980457321;8029.07665618438;8042.437029407885;8132.105468398589;9593.184579310837;9801.9019809801;9832.262580306362;9851.556679949275;9943.055409736064;9845.901540984498;10144.985501449795;10157.288989770645;10276.845847312446;10320;7480.775576732707;7509.624518774149;7591.202923692933;7631.427642926692;7705.30652241301;8430.156984301766;8468.237858592756;8496.235338819535;8504.40469167177;8505.659773609234;6526.902096468461;6539.7384104637185;7418.629068546443;7457.477976541807;7639.579823109782;7436.888446673413;7437.144728356092;7458.328750412489;7506;7521.022267105242;7842.64708088126;7955.801104972422;7959.482633628795;7963.283304502623;7978.601069946363;7101.893471597827;7111.6799744010605;7196.8920466192;7210.459215558749;7216.639168041682;7227.313405226495;7293.671784769805;7294.598797066213;7304.123505179413;7354.852902942018 02:46:13 INFO - PROCESS | 1669 | |4;prototype.html;331.7578167937406;337;340.94374428219345;341.2288228603356;346.81445426696723;6683.665816709164;6689.8996515052195;6701.765438209658;6753.527253092286;6793.150856142982;6643.236027856798;6650.933490665092;6664.333566643333;6673.966630166855;6700.095487109239;4308.3537469379535;4496.168208881351;4724.692894961834;4951.356323677916;4989.525995030484;4962.007598480301;4971.179755340365;4981.078500477423;4987.027529631723;4999.8000079996755;4929.309896614459;4938;4947.109520286347;4950.381202349707;4972.154733695263;3938.6652134568594;4674.859754207379;4723.173444647173;4939.259111133323;4982.850514484571;3475.391806433864;4252.829886804524;4288.656907447396;4300.311950087971;4300.333448315516;4796.904061918742;6371.52213583983;6410.455111315544;6504.869902601921;6545.247296560861;5119.59043276537;5749.511291540224;5849.181114643953;5858;5870.354261031283;5710;7046.295370462964;7047.088865679546;7062.470314726416;7065.187503437068;4398.560143985608;4544.250198717207;4555.840545580922;4575.153596584642;4578.2903649934315;7197.748078817216;7347.816304592375;7403.481756277063;7443.441741869327;7452.329290363893;4660.650451216173;4667.136579732693;4678.602318802872;4684.531546845288;4695.154872123051;4743.952560474351;4757.310190022427;4757.5718185363485;4757.833475828399;4761.40482439695;5601.60788744784;5602.971985140048;5611.438856114356;5624.29696287964;5631.4087020863035;6807.897881531781;7016.438684905195;7043;7046.964765176142;7100.893486597705;1635.942742004048;1646.6788976149535;1655.3047719957647;1659.2035822805121;1660.435451946344;999.9450030248406;1024.3137098144261;1056.8467572201987;1063.7819247054335;1082.2640604389092;6573.868522629521;6713.429358504484;6722.462203023746;6726.596404215763;6740.9662951685905;7414.332710056121;7418.851622967619;7427.4800763946005;7448.5158464699625;7449.702011919462;6667.099941507931;6672.8999065013095;6678.699458524378;6687.866242675216;6721.4958878084335;3211.983940080331;3792.543607816686;3850.364689826203;3905.6484916357094;3922.7057970652313;7575.2424757524905;7718.884216736754;7735.7679269622;7736.690532378754;7751.573663448565;7553.395728341829;7622.047244094489;7622.161562228151;7628.618569071524;7636.732714354971;6259.62442253448;7703.075630924212;7714.961425192838;7725.7295994641045;7743.728969486154;5949.226600542075;7058.082449281561;7351.00761397226;7373.889391659022;7389.076365454318;5883.499902508334;7150.928490715234;7178;7182.569045857265;7197.172325182671;7725.690972361042;7728.536287822749;7763.68945242184;7767.184445633353;7775.961120194363;4669.7431641260055;4721.527847215251;4733.881652958704;4734.73958932262;4745.240761478285;7079;7401.7039318428815;7404.185539590749;7415.147258065392;7420.5176663516695;7138.535995160506;7176.174739904978;7180.676869540779;7180.74336991014;7184.856302874018;7097.574145551283;7151.392131668867;7152.856942861218;7166.068411106523;7186.353228209487;6975.6163411012885;6981.5112942093565;6986.650667466504;6987.790366289019;7034.894476582753;6942.49202842825;7055.717771289091;7137.892931605927;7147.964260178665;7154.320339567733;6616.106825578485;6833.521653484408;6857.5199736019995;7000.789976300719;7013.929860701328 02:46:13 INFO - PROCESS | 1669 | |5;yui.html;678.7454704485817;680.5304340005396;692.9896051559226;727.3926271563242;729.4711334282642;15070.020448670843;15393.076415415055;15429;15461.994970326936;15478.4582539611;14399.568012959602;14619.561413157622;14632;14633.487827926025;14657.706845863077;816.9468984516017;820.9507429554216;827.4910929778173;968.7965527239288;986.4870267460952;816.1838161838161;818.9918100818975;960.6205548808216;982.5578489679637;985.1675334342469;1050.2648146297622;1054.098745572536;1054.3621109228882;1055.9915280906755;1056.7410984308856;1038.0709265207672;1040.9479526023667;1041.0162396535277;1041.338749893823;1042.880068792091;628.2680677011322;773.157258588136;787.0830482487895;789.1634867040955;792.0890975378361;15903.443379481778;15945.441909533227;15967.760483592756;15998.96006759557;16136.838631613768;10949.562017519289;12914;12968.675783105404;13319.53381631648;13420.731585368336;9831.557579908922;10100.545475453622;10170.847437288447;10361.171106311476;10389.116925061378;3634.200475895299;3665.541807274091;3761.360568703327;3785.1483416231404;3907.8827635170705;88163.55918220432;88443;88847;89158.32525024259;89426.55286723525;9895.406275623485;9961.40231586107;9968.501574921225;10413.062824345694;10777.461126943621;23830.285091447284;23852.88073559656;23899.641505377433;23936.281911542683;24245;7912.802179945547;7997.5601341925585;8033.598320084089;8071.112177660452;8162.918370816215;4194.664426845845;4264.509581398117;4305.763183024964;4330.610245077895;4331.090471001062;3767.604401537854;3813;3814.237152569497;3814.7138964577766;3815.4086116651965;684.9280825513349;687.7042871565175;691.1153723234269;703.7888633409957;707.734599525178;581.7004242814953;605.4036773777825;609.8749756300036;614.2628845385466;635.7607987304675;8245.257926786619;8260.380471464665;8310.318106856867;8381.916180838236;8439.198276163756;590.6574186971546;596.1207219351509;625.1872565664618;626.5614070150913;635.9872802543923;3821.426785982125;3891.2606604745006;3912.941305880414;3984.30274701926;4076.735012224196;96975.51512242394;98073.50963245281;98455.50772246237;99367.50316248373;99409.50295248478;83064;84733.72899406514;85389.57305213559;85633;85951.57024214839;75437.99999999891;75497.6225118871;75546;76601;77286.61356693292;7779.988601481771;7993;8017.879731804144;8052.597370131352;8244.793880153044;40534.594654054265;53146.468535314154;53381.19928201003;53553.464465354846;53606.73196633992;70045.29954700387;75597.24402755902;76224;76248.61875690808;76983.2301676976;10389.116925061455;10414;10515.474226288808;10577.471126443801;11134.053605443629;10756;10782.029617334478;10959.287646302964;11085.22403431752;11750.059995200534;10478.423686697304;10661.520231589442;10663.520141593492;10745.194110441591;11969.461374238006;11459.36973466434;11575.363355015555;11633;11753.118516111497;11878.168528202943;11355.37545435009;11408.885911140782;11564.13269004845;12013.939930300292;12046.277223366276;9530.475823829756;9701.757456063655;10009.199264059003;10089.243306751876;10286.228532859916;7065.792891250998;9476.810463790824;9677.322587418814;9683.225341972766;9708.689476438429 02:46:13 INFO - PROCESS | 1669 | __end_tp_report 02:46:13 INFO - PROCESS | 1669 | __start_cc_report 02:46:13 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,993 02:46:13 INFO - PROCESS | 1669 | __end_cc_report 02:46:13 INFO - PROCESS | 1669 | __startTimestamp1458121573393__endTimestamp 02:46:13 INFO - PROCESS | 1669 | 02:46:13 INFO - PROCESS | 1669 | ------- Summary: start ------- 02:46:13 INFO - PROCESS | 1669 | Number of tests: 6 02:46:13 INFO - PROCESS | 1669 | 02:46:13 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5807.62 Median:6102.27 stddev:657.78 (10.8%) stddev-sans-first:633.27 02:46:13 INFO - PROCESS | 1669 | Values: 3450.3 3506.6 3522.1 3544.2 3598.1 5814.6 5836.9 5837.2 5861.8 5879.8 5842.3 5858.3 5870.5 5873.4 5875.6 5166.4 5237.4 5278.3 5313.7 5361.4 5333.1 5334.5 5361.8 5363.4 5363.5 5256.9 5333.5 5360.9 5362.1 5373.1 4698.5 5327.2 5361.4 5366.7 5404.9 4253.5 5195.2 5254.8 5265.4 5270.4 5691.1 5696.0 5749.4 5752.5 5762.3 5214.5 6156.9 6267.4 6270.6 6289.9 6222.1 6240.0 6251.6 6272.7 6298.0 5933.5 5951.8 5969.5 5973.9 5978.7 6226.8 6306.1 6384.1 6388.8 6407.7 6219.5 6245.4 6259.2 6259.6 6280.1 6271.5 6276.1 6285.4 6304.8 6309.2 6148.0 6166.6 6182.0 6241.4 6267.9 5262.8 6215.7 6266.2 6280.7 6286.2 4979.6 4992.8 4994.6 5006.1 5007.5 3831.5 4330.5 4392.5 4500.2 4536.2 5851.2 5852.1 5865.3 5866.1 5891.4 6239.5 6256.9 6259.7 6263.4 6285.2 5787.3 5832.0 5847.1 5918.7 5957.5 5441.6 5471.9 5476.4 5480.9 5482.0 6401.8 6459.3 6461.7 6466.2 6472.3 6180.0 6243.3 6244.2 6286.7 6295.6 6442.5 6445.4 6449.5 6458.7 6466.5 6192.3 6192.8 6230.3 6247.9 6277.7 6191.1 6195.9 6247.9 6276.1 6287.8 4883.0 6144.2 6234.7 6253.1 6260.1 6088.8 6264.5 6265.4 6283.0 6288.6 6040.7 6142.9 6152.5 6154.0 6155.7 6218.9 6237.5 6246.5 6263.6 6263.6 5897.7 6096.0 6102.3 6120.8 6134.0 02:46:13 INFO - PROCESS | 1669 | 02:46:13 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:61997.40 Median:209341.41 stddev:121453.71 (58.0%) stddev-sans-first:121706.60 02:46:13 INFO - PROCESS | 1669 | Values: 481.7 605.4 615.0 621.8 656.5 26157.2 32373.2 40416.6 40675.6 40796.6 44202.8 44754.3 44769.0 44779.0 44832.1 9730.5 9953.3 9957.7 9958.6 9967.3 9682.1 9770.5 9807.8 9848.6 9855.0 8918.7 9642.3 9877.6 9963.0 9983.0 9865.2 9941.4 9944.3 9947.2 9950.0 9812.6 9943.5 9951.3 9961.4 9962.6 42094.8 42254.8 42480.6 42502.8 42546.8 3292.5 3411.7 3427.2 3529.1 3796.2 29714.6 29860.0 29915.1 30275.4 30396.8 2772.6 2788.8 2802.6 2823.7 2886.7 517165.0 521129.0 524464.0 525177.0 527048.0 70527.0 72023.6 72653.6 72765.6 72771.0 77769.6 78718.8 79015.0 79135.8 79142.0 18336.0 18497.7 18509.2 18524.1 18535.9 13720.4 13775.2 13812.8 13816.4 13823.2 22620.7 22702.4 22718.9 22974.8 22990.4 8388.2 9713.2 9781.8 9872.9 9904.5 982.8 998.3 1067.9 1072.2 1137.6 25113.7 30583.1 30653.1 31176.4 31197.4 1036.6 1153.3 1175.3 1207.7 1246.8 15989.6 16323.3 16383.3 16531.6 16570.0 455850.0 459266.0 460850.0 461160.0 461798.0 60367.7 60977.0 60981.7 60981.8 61135.0 1450.1 1510.6 1574.9 1585.7 1592.1 29381.3 30524.5 30719.0 30980.2 31061.8 41002.0 50175.7 50527.2 50547.0 50682.7 378545.0 379747.0 380691.0 381702.0 381741.0 30419.9 34741.5 34800.5 35155.5 35672.6 42795.4 45048.3 49058.3 50300.0 50451.7 36724.8 36730.3 37152.6 37479.8 38214.8 37148.8 37193.8 37535.4 37880.8 37884.6 36318.0 36794.8 37370.0 37917.6 37991.8 33728.0 33861.5 34754.3 34824.5 35472.8 24585.0 25601.9 25749.6 25988.0 26448.9 02:46:13 INFO - PROCESS | 1669 | 02:46:13 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:33629.52 Median:11738.95 stddev:99555.96 (848.1%) stddev-sans-first:99803.86 02:46:13 INFO - PROCESS | 1669 | Values: 335.8 360.8 371.5 382.6 393.6 17215.6 20072.6 20773.8 20974.3 21109.5 20149.9 20539.7 21160.0 21195.7 22236.1 5805.2 5976.6 5978.3 6018.5 6031.0 4372.6 4398.2 4571.7 6441.5 6463.2 6363.5 6392.4 6396.8 6399.2 6414.7 5739.7 6005.8 6015.2 6019.5 6377.7 4012.7 4650.4 5726.3 5751.5 5766.0 13509.7 13737.6 13951.0 13980.4 14391.3 2138.5 2170.9 2351.5 2372.8 2805.9 9942.9 10025.9 10162.7 10572.2 10613.1 1779.6 1800.4 1807.1 1845.1 1848.0 80861.0 113740.4 115244.0 117968.0 119671.2 9470.2 11977.3 11994.7 12032.0 12161.5 14505.2 14537.4 14550.5 14569.5 14575.0 8755.3 9024.7 9026.0 9085.7 9123.5 9245.3 9280.7 9282.7 9359.2 9362.4 4620.7 4701.0 4708.9 4709.4 4737.2 1946.4 1975.2 1991.4 1993.1 1998.6 913.5 992.3 992.5 1023.9 1096.5 20654.2 21097.4 21273.5 21309.6 21339.4 972.4 1029.9 1034.9 1082.1 1085.2 9252.2 10894.7 11322.3 11476.3 11510.5 275384.0 626422.9 658352.0 658479.4 673589.0 99051.5 109785.0 116942.0 118339.4 122798.0 1028.1 1032.8 1055.1 1056.6 1056.7 15538.4 17930.4 18108.5 18181.3 19098.7 53417.5 54606.7 54949.7 55714.9 55783.0 74670.9 76916.6 77628.2 79484.0 80043.4 8074.1 8235.1 8270.3 8310.1 8604.0 9589.7 10571.5 11449.6 13834.0 14092.1 10530.5 11629.1 11696.7 11754.4 12142.1 7521.2 8158.0 11678.3 11769.9 12050.8 12029.4 12057.1 12223.4 12377.2 12391.3 8521.7 8645.8 8658.4 8722.3 8771.1 8761.2 11253.9 11980.2 12074.3 12134.7 02:46:13 INFO - PROCESS | 1669 | 02:46:13 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:6188.72 Median:5000.76 stddev:3247.94 (64.9%) stddev-sans-first:3237.25 02:46:13 INFO - PROCESS | 1669 | Values: 1418.6 1472.6 1625.5 1883.0 2058.6 8103.4 8727.2 8894.4 8909.4 8935.5 8651.0 8894.5 8901.5 8901.9 8903.7 2537.9 2563.6 2567.0 2567.8 2568.7 2506.6 2565.4 2567.1 2569.7 2572.6 2388.9 2493.5 2512.3 2512.9 2513.3 2545.0 2569.0 2572.8 2576.7 2579.4 2529.9 2565.2 2572.6 2573.6 2578.7 8945.6 9018.0 9025.1 9028.0 9043.5 5279.4 5399.6 5415.8 5451.3 5454.0 3614.2 3712.3 3747.6 3766.9 3776.8 919.4 1046.2 1070.2 1080.6 1099.8 12348.4 12370.3 12371.9 12379.6 12393.4 4853.0 4934.8 4992.4 4993.1 5008.4 10332.7 10346.4 10350.9 10351.9 10354.6 5583.3 5585.9 5591.2 5601.8 5628.4 4540.2 4615.2 4860.9 4985.9 5111.3 3974.6 4045.1 4051.2 4079.4 4103.7 1334.9 1338.3 1339.4 1357.5 1368.6 1052.0 1087.2 1186.9 1353.1 1454.2 8143.5 8151.8 8253.3 8289.0 8291.5 1038.6 1232.0 1232.5 1255.0 1267.6 6258.4 6295.9 6371.6 6374.9 6376.9 10458.3 10893.2 10912.8 10984.3 10996.3 10575.2 10637.8 10800.9 10868.3 10882.3 8377.3 8488.7 8523.2 8545.5 8545.6 7967.7 7974.1 8029.1 8042.4 8132.1 9593.2 9801.9 9832.3 9851.6 9943.1 9845.9 10145.0 10157.3 10276.8 10320.0 7480.8 7509.6 7591.2 7631.4 7705.3 8430.2 8468.2 8496.2 8504.4 8505.7 6526.9 6539.7 7418.6 7457.5 7639.6 7436.9 7437.1 7458.3 7506.0 7521.0 7842.6 7955.8 7959.5 7963.3 7978.6 7101.9 7111.7 7196.9 7210.5 7216.6 7227.3 7293.7 7294.6 7304.1 7354.9 02:46:13 INFO - PROCESS | 1669 | 02:46:13 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:5797.19 Median:6676.33 stddev:1870.77 (28.0%) stddev-sans-first:1830.48 02:46:13 INFO - PROCESS | 1669 | Values: 331.8 337.0 340.9 341.2 346.8 6683.7 6689.9 6701.8 6753.5 6793.2 6643.2 6650.9 6664.3 6674.0 6700.1 4308.4 4496.2 4724.7 4951.4 4989.5 4962.0 4971.2 4981.1 4987.0 4999.8 4929.3 4938.0 4947.1 4950.4 4972.2 3938.7 4674.9 4723.2 4939.3 4982.9 3475.4 4252.8 4288.7 4300.3 4300.3 4796.9 6371.5 6410.5 6504.9 6545.2 5119.6 5749.5 5849.2 5858.0 5870.4 5710.0 7046.3 7047.1 7062.5 7065.2 4398.6 4544.3 4555.8 4575.2 4578.3 7197.7 7347.8 7403.5 7443.4 7452.3 4660.7 4667.1 4678.6 4684.5 4695.2 4744.0 4757.3 4757.6 4757.8 4761.4 5601.6 5603.0 5611.4 5624.3 5631.4 6807.9 7016.4 7043.0 7047.0 7100.9 1635.9 1646.7 1655.3 1659.2 1660.4 999.9 1024.3 1056.8 1063.8 1082.3 6573.9 6713.4 6722.5 6726.6 6741.0 7414.3 7418.9 7427.5 7448.5 7449.7 6667.1 6672.9 6678.7 6687.9 6721.5 3212.0 3792.5 3850.4 3905.6 3922.7 7575.2 7718.9 7735.8 7736.7 7751.6 7553.4 7622.0 7622.2 7628.6 7636.7 6259.6 7703.1 7715.0 7725.7 7743.7 5949.2 7058.1 7351.0 7373.9 7389.1 5883.5 7150.9 7178.0 7182.6 7197.2 7725.7 7728.5 7763.7 7767.2 7776.0 4669.7 4721.5 4733.9 4734.7 4745.2 7079.0 7401.7 7404.2 7415.1 7420.5 7138.5 7176.2 7180.7 7180.7 7184.9 7097.6 7151.4 7152.9 7166.1 7186.4 6975.6 6981.5 6986.7 6987.8 7034.9 6942.5 7055.7 7137.9 7148.0 7154.3 6616.1 6833.5 6857.5 7000.8 7013.9 02:46:13 INFO - PROCESS | 1669 | 02:46:13 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:19431.35 Median:53263.83 stddev:27949.41 (52.5%) stddev-sans-first:27992.35 02:46:13 INFO - PROCESS | 1669 | Values: 678.7 680.5 693.0 727.4 729.5 15070.0 15393.1 15429.0 15462.0 15478.5 14399.6 14619.6 14632.0 14633.5 14657.7 816.9 821.0 827.5 968.8 986.5 816.2 819.0 960.6 982.6 985.2 1050.3 1054.1 1054.4 1056.0 1056.7 1038.1 1040.9 1041.0 1041.3 1042.9 628.3 773.2 787.1 789.2 792.1 15903.4 15945.4 15967.8 15999.0 16136.8 10949.6 12914.0 12968.7 13319.5 13420.7 9831.6 10100.5 10170.8 10361.2 10389.1 3634.2 3665.5 3761.4 3785.1 3907.9 88163.6 88443.0 88847.0 89158.3 89426.6 9895.4 9961.4 9968.5 10413.1 10777.5 23830.3 23852.9 23899.6 23936.3 24245.0 7912.8 7997.6 8033.6 8071.1 8162.9 4194.7 4264.5 4305.8 4330.6 4331.1 3767.6 3813.0 3814.2 3814.7 3815.4 684.9 687.7 691.1 703.8 707.7 581.7 605.4 609.9 614.3 635.8 8245.3 8260.4 8310.3 8381.9 8439.2 590.7 596.1 625.2 626.6 636.0 3821.4 3891.3 3912.9 3984.3 4076.7 96975.5 98073.5 98455.5 99367.5 99409.5 83064.0 84733.7 85389.6 85633.0 85951.6 75438.0 75497.6 75546.0 76601.0 77286.6 7780.0 7993.0 8017.9 8052.6 8244.8 40534.6 53146.5 53381.2 53553.5 53606.7 70045.3 75597.2 76224.0 76248.6 76983.2 10389.1 10414.0 10515.5 10577.5 11134.1 10756.0 10782.0 10959.3 11085.2 11750.1 10478.4 10661.5 10663.5 10745.2 11969.5 11459.4 11575.4 11633.0 11753.1 11878.2 11355.4 11408.9 11564.1 12013.9 12046.3 9530.5 9701.8 10009.2 10089.2 10286.2 7065.8 9476.8 9677.3 9683.2 9708.7 02:46:13 INFO - PROCESS | 1669 | -------- Summary: end -------- 02:46:13 INFO - PROCESS | 1669 | 02:46:13 INFO - TEST-INFO | 1669: exit 0 02:46:13 INFO - TEST-OK | dromaeo_css | took 1113266ms 02:46:13 INFO - TEST-START | kraken 02:46:13 INFO - operating with platform_type : mac_ 02:46:13 INFO - Initialising browser for kraken test... 02:46:13 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmpgS76Jo/profile http://localhost:49272/getInfo.html) 02:46:16 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 02:46:16 INFO - PROCESS | 1675 | colorDepth:24 02:46:16 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 02:46:16 INFO - PROCESS | 1675 | __metrics 02:46:16 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" 02:46:16 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] 02:46:16 INFO - TEST-INFO | 1675: exit 0 02:46:16 INFO - Browser initialized. 02:46:16 INFO - Running cycle 1/1 for kraken test... 02:46:16 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmpgS76Jo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:46:28 INFO - PROCESS | 1678 | RSS: Main: 210632704 02:46:28 INFO - PROCESS | 1678 | 02:46:31 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 02:46:31 INFO - PROCESS | 1678 | RSS: Main: 266043392 02:46:31 INFO - PROCESS | 1678 | 02:46:34 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 02:46:35 INFO - PROCESS | 1678 | RSS: Main: 274382848 02:46:35 INFO - PROCESS | 1678 | 02:46:38 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 02:46:38 INFO - PROCESS | 1678 | RSS: Main: 265646080 02:46:38 INFO - PROCESS | 1678 | 02:46:40 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 02:46:41 INFO - PROCESS | 1678 | RSS: Main: 267960320 02:46:41 INFO - PROCESS | 1678 | 02:46:43 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:46:44 INFO - PROCESS | 1678 | RSS: Main: 268718080 02:46:44 INFO - PROCESS | 1678 | 02:46:46 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 02:46:47 INFO - PROCESS | 1678 | RSS: Main: 269217792 02:46:47 INFO - PROCESS | 1678 | 02:46:50 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 02:46:50 INFO - PROCESS | 1678 | RSS: Main: 268034048 02:46:50 INFO - PROCESS | 1678 | 02:46:53 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 02:46:54 INFO - PROCESS | 1678 | RSS: Main: 269606912 02:46:54 INFO - PROCESS | 1678 | 02:46:55 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:46:56 INFO - PROCESS | 1678 | RSS: Main: 301764608 02:46:56 INFO - PROCESS | 1678 | 02:46:57 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:46:58 INFO - PROCESS | 1678 | RSS: Main: 301178880 02:46:58 INFO - PROCESS | 1678 | 02:47:00 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:47:01 INFO - PROCESS | 1678 | RSS: Main: 307208192 02:47:01 INFO - PROCESS | 1678 | 02:47:03 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:47:04 INFO - PROCESS | 1678 | RSS: Main: 308056064 02:47:04 INFO - PROCESS | 1678 | 02:47:06 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:47:07 INFO - PROCESS | 1678 | RSS: Main: 309497856 02:47:07 INFO - PROCESS | 1678 | 02:47:09 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 02:47:09 INFO - PROCESS | 1678 | RSS: Main: 368820224 02:47:09 INFO - PROCESS | 1678 | 02:47:09 INFO - PROCESS | 1678 | __start_tp_report 02:47:09 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 02:47:09 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 02:47:09 INFO - PROCESS | 1678 | |i|pagename|runs| 02:47:09 INFO - PROCESS | 1678 | |0;ai-astar;112;108;110;111;111;111;120;110;109;109 02:47:09 INFO - PROCESS | 1678 | |1;audio-beat-detection;152;119;143;180;149;139;115;152;145;117 02:47:09 INFO - PROCESS | 1678 | |2;audio-dft;188;182;181;187;187;185;184;184;185;184 02:47:09 INFO - PROCESS | 1678 | |3;audio-fft;76;75;73;117;55;55;58;57;118;53 02:47:09 INFO - PROCESS | 1678 | |4;audio-oscillator;89;95;128;80;78;84;116;76;79;116 02:47:09 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;93;130;88;84;87;84;88;84;88;86 02:47:09 INFO - PROCESS | 1678 | |6;imaging-darkroom;143;93;92;92;91;92;92;92;92;92 02:47:09 INFO - PROCESS | 1678 | |7;imaging-desaturate;86;90;84;84;85;84;84;87;85;81 02:47:09 INFO - PROCESS | 1678 | |8;json-parse-financial;56;57;58;57;57;58;57;67;54;52 02:47:09 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;64;62;69;66;76;71;66;66;65;71 02:47:09 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;80;79;80;81;79;80;91;103;104;107 02:47:09 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;118;118;117;122;128;115;119;130;129;128 02:47:09 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;132;120;131;132;132;118;155;166;146;132 02:47:09 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;66;65;66;65;64;66;67;67;65;65 02:47:09 INFO - PROCESS | 1678 | __end_tp_report 02:47:09 INFO - PROCESS | 1678 | __start_cc_report 02:47:09 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1167 02:47:09 INFO - PROCESS | 1678 | __end_cc_report 02:47:09 INFO - PROCESS | 1678 | __startTimestamp1458121629431__endTimestamp 02:47:09 INFO - PROCESS | 1678 | 02:47:09 INFO - PROCESS | 1678 | ------- Summary: start ------- 02:47:09 INFO - PROCESS | 1678 | Number of tests: 14 02:47:09 INFO - PROCESS | 1678 | 02:47:09 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:3.35 (3.0%) stddev-sans-first:3.54 02:47:09 INFO - PROCESS | 1678 | Values: 112.0 108.0 110.0 111.0 111.0 111.0 120.0 110.0 109.0 109.0 02:47:09 INFO - PROCESS | 1678 | 02:47:09 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:147.00 stddev:19.96 (13.6%) stddev-sans-first:20.78 02:47:09 INFO - PROCESS | 1678 | Values: 152.0 119.0 143.0 180.0 149.0 139.0 115.0 152.0 145.0 117.0 02:47:09 INFO - PROCESS | 1678 | 02:47:09 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.00 stddev:2.21 (1.2%) stddev-sans-first:2.00 02:47:09 INFO - PROCESS | 1678 | Values: 188.0 182.0 181.0 187.0 187.0 185.0 184.0 184.0 185.0 184.0 02:47:09 INFO - PROCESS | 1678 | 02:47:09 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:73.70 Median:57.50 stddev:24.72 (43.0%) stddev-sans-first:26.20 02:47:09 INFO - PROCESS | 1678 | Values: 76.0 75.0 73.0 117.0 55.0 55.0 58.0 57.0 118.0 53.0 02:47:09 INFO - PROCESS | 1678 | 02:47:09 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:79.50 stddev:19.01 (23.9%) stddev-sans-first:20.07 02:47:09 INFO - PROCESS | 1678 | Values: 89.0 95.0 128.0 80.0 78.0 84.0 116.0 76.0 79.0 116.0 02:47:09 INFO - PROCESS | 1678 | 02:47:09 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:91.20 Median:87.50 stddev:13.90 (15.9%) stddev-sans-first:14.73 02:47:09 INFO - PROCESS | 1678 | Values: 93.0 130.0 88.0 84.0 87.0 84.0 88.0 84.0 88.0 86.0 02:47:09 INFO - PROCESS | 1678 | 02:47:09 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:97.10 Median:92.00 stddev:16.13 (17.5%) stddev-sans-first:0.50 02:47:09 INFO - PROCESS | 1678 | Values: 143.0 93.0 92.0 92.0 91.0 92.0 92.0 92.0 92.0 92.0 02:47:09 INFO - PROCESS | 1678 | 02:47:09 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:2.36 (2.8%) stddev-sans-first:2.47 02:47:09 INFO - PROCESS | 1678 | Values: 86.0 90.0 84.0 84.0 85.0 84.0 84.0 87.0 85.0 81.0 02:47:09 INFO - PROCESS | 1678 | 02:47:09 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.00 stddev:3.89 (6.8%) stddev-sans-first:4.10 02:47:09 INFO - PROCESS | 1678 | Values: 56.0 57.0 58.0 57.0 57.0 58.0 57.0 67.0 54.0 52.0 02:47:09 INFO - PROCESS | 1678 | 02:47:09 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:67.50 stddev:4.14 (6.1%) stddev-sans-first:4.18 02:47:09 INFO - PROCESS | 1678 | Values: 64.0 62.0 69.0 66.0 76.0 71.0 66.0 66.0 65.0 71.0 02:47:09 INFO - PROCESS | 1678 | 02:47:09 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:80.00 stddev:11.80 (14.7%) stddev-sans-first:12.11 02:47:09 INFO - PROCESS | 1678 | Values: 80.0 79.0 80.0 81.0 79.0 80.0 91.0 103.0 104.0 107.0 02:47:09 INFO - PROCESS | 1678 | 02:47:09 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:122.40 Median:125.00 stddev:5.76 (4.6%) stddev-sans-first:5.88 02:47:09 INFO - PROCESS | 1678 | Values: 118.0 118.0 117.0 122.0 128.0 115.0 119.0 130.0 129.0 128.0 02:47:09 INFO - PROCESS | 1678 | 02:47:09 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.40 Median:132.00 stddev:15.01 (11.4%) stddev-sans-first:15.84 02:47:09 INFO - PROCESS | 1678 | Values: 132.0 120.0 131.0 132.0 132.0 118.0 155.0 166.0 146.0 132.0 02:47:09 INFO - PROCESS | 1678 | 02:47:09 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 02:47:09 INFO - PROCESS | 1678 | Values: 66.0 65.0 66.0 65.0 64.0 66.0 67.0 67.0 65.0 65.0 02:47:09 INFO - PROCESS | 1678 | -------- Summary: end -------- 02:47:09 INFO - PROCESS | 1678 | 02:47:10 INFO - TEST-INFO | 1678: exit 0 02:47:10 INFO - TEST-OK | kraken | took 56265ms 02:47:10 INFO - SUITE-END | took 1169s 02:47:10 INFO - Completed test suite (00:19:29) 02:47:10 INFO - javascript benchmark 02:47:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3450.3271861986914, 3506.6148871195896, 3522.0842580928966, 3544.2379888324012, 3598.0824889653136, 5814.563907706923, 5836.912446313303, 5837.182794408775, 5861.76552937883, 5879.823605291843, 5842.2989241291, 5858.2677165354335, 5870.501007414364, 5873.383294754053, 5875.559333050028, 5166.380034395877, 5237.3715154181555, 5278.340207474056, 5313.654612450178, 5361.383440904287, 5333.120035194188, 5334.546563542103, 5361.758720857571, 5363.383210930734, 5363.463653634625, 5256.92114618281, 5333.546648534879, 5360.9463905361035, 5362.088444964346, 5373.113436283009, 4698.506656801055, 5327.174287985368, 5361.383440904268, 5366.70483123428, 5404.891902161974, 4253.532111467736, 5195.168772996302, 5254.842354729364, 5265.447128051576, 5270.420253772082, 5691.117876729114, 5695.971520142414, 5749.367569567345, 5752.453516915886, 5762.279715035621, 5214.5306922376785, 6156.922538555735, 6267.4045965633195, 6270.623762574214, 6289.937100628981, 6222.097795819626, 6239.970404883189, 6251.624902505864, 6272.717727702265, 6297.968510157466, 5933.495652869511, 5951.821445356646, 5969.462748352713, 5973.940260597426, 5978.701064946736, 6226.844328891814, 6306.085617585516, 6384.106225128486, 6388.776392826228, 6407.7436902524305, 6219.502439804804, 6245.437910587978, 6259.217597800275, 6259.593126446766, 6280.120783090371, 6271.4669253114, 6276.089966954857, 6285.43431091204, 6304.810855674337, 6309.242890853127, 6148.016317389286, 6166.630002199792, 6181.96909015452, 6241.407066328691, 6267.874642507124, 5262.7631756571045, 6215.689215539205, 6266.24805023391, 6280.717367718464, 6286.245650521967, 4979.551840334388, 4992.825251116194, 4994.600431965434, 5006.123928312531, 5007.524285192901, 3831.501904752364, 4330.458692663417, 4392.516823149451, 4500.189965806121, 4536.183486972377, 5851.1515830205235, 5852.122181672698, 5865.266841644794, 5866.120081987736, 5891.41085891416, 6239.532035097386, 6256.874862502816, 6259.7496100156395, 6263.404976527223, 6285.245770507477, 5787.334456537468, 5832.0, 5847.093700476433, 5918.704064796743, 5957.463828255478, 5441.646292990943, 5471.945280547144, 5476.397596264408, 5480.91778623321, 5482.0, 6401.775937842246, 6459.321771214143, 6461.709223084972, 6466.159399278064, 6472.3204063573585, 6179.969100154471, 6243.250809902659, 6244.219472565929, 6286.685665716787, 6295.5907865988565, 6442.452391546583, 6445.355464453517, 6449.451796597342, 6458.67706614658, 6466.547341686037, 6192.349803270772, 6192.783252586138, 6230.283517395557, 6247.937520624736, 6277.74889004453, 6191.102290167991, 6195.884740746709, 6247.875042499216, 6276.089966954674, 6287.779927702509, 4882.975585122052, 6144.2319710036245, 6234.688265586612, 6253.1245625613365, 6260.060990851409, 6088.786892458743, 6264.467520260829, 6265.4361107500545, 6283.0, 6288.5598008138995, 6040.6677632730625, 6142.9078563820685, 6152.507799376129, 6154.0, 6155.722992465439, 6218.875622487615, 6237.5009999200865, 6246.531510136667, 6263.561550691408, 6263.592866463665, 5897.734601943009, 6096.0, 6102.267727872683, 6120.816375508742, 6134.04922237054], "unit": "score", "name": "dojo.html", "value": 5766.858549922816}, {"lowerIsBetter": false, "replicates": [481.7013451659971, 605.4490413723513, 614.9631022138675, 621.847647326405, 656.47154040997, 26157.2152835415, 32373.21947292898, 40416.59583404169, 40675.59324406755, 40796.572119975805, 44202.778986105026, 44754.32868506975, 44769.0, 44779.0, 44832.10335793282, 9730.464824434654, 9953.253505987044, 9957.701268961942, 9958.601655933753, 9967.302288839785, 9682.080202380797, 9770.462624555646, 9807.754806129833, 9848.556814943344, 9855.0, 8918.73243802687, 9642.2768292378, 9877.60489580416, 9962.950185249063, 9983.001699829994, 9865.210783137367, 9941.353812002233, 9944.303898727092, 9947.1544918682, 9949.950250248774, 9812.607495700235, 9943.5028248588, 9951.303408761389, 9961.40231586107, 9962.601495940155, 42094.84288678361, 42254.78872605648, 42480.57519424828, 42502.78748606268, 42546.78726606378, 3292.539044533767, 3411.727061835047, 3427.160345715291, 3529.1353618363664, 3796.1648437343742, 29714.554281685792, 29860.0, 29915.102546923627, 30275.394492110256, 30396.848015760002, 2772.5841123831383, 2788.8326700398043, 2802.5936239245193, 2823.745862872351, 2886.740193382606, 517165.0, 521129.0, 524464.0, 525177.0, 527048.0, 70527.0, 72023.6398818013, 72653.636731816, 72765.6361718188, 72771.0, 77769.611151945, 78718.81921771177, 79015.0, 79135.8129628056, 79142.0, 18335.991520466236, 18497.722534162, 18509.167087481095, 18524.07379631013, 18535.907320463582, 13720.382582783799, 13775.173489590657, 13812.792808107886, 13816.447342106405, 13823.170609763447, 22620.660690089662, 22702.432439189153, 22718.864056797094, 22974.770252297596, 22990.42523936915, 8388.238469921385, 9713.22294216461, 9781.755456113511, 9872.901270987342, 9904.504774761233, 982.7887004294112, 998.2612866478753, 1067.8771941226703, 1072.2387105155271, 1137.5790957345835, 25113.748862511507, 30583.08250752481, 30653.080407587808, 31176.376472470878, 31197.376052478823, 1036.5646428500047, 1153.313778301909, 1175.2948231061466, 1207.7463732616072, 1246.7755803955374, 15989.600259993593, 16323.26545305464, 16383.344666213456, 16531.586710332336, 16570.0, 455850.0, 459266.0, 460850.0, 461160.0, 461798.0, 60367.69816150891, 60977.0, 60981.695091525144, 60981.78036439335, 61135.0, 1450.1299220467845, 1510.5996910818642, 1574.944876929302, 1585.6907902959042, 1592.076595574564, 29381.265468362606, 30524.542131868486, 30719.0, 30980.22549436192, 31061.762387893406, 41001.97495062528, 50175.74912125416, 50527.24209136792, 50547.0, 50682.73293167553, 378545.0, 379747.0, 380691.0, 381702.0, 381741.0, 30419.935302264315, 34741.47887781736, 34800.47799283063, 35155.472667910515, 35672.64327356797, 42795.358069629605, 45048.324275135245, 49058.264126038855, 50300.0, 50451.73870653263, 36724.81637591795, 36730.26539469249, 37152.628473715995, 37479.81260093682, 38214.80892595519, 37148.81425592963, 37193.81403092967, 37535.43696844604, 37880.810595946845, 37884.62115378921, 36318.0, 36794.816025919696, 37370.0, 37917.62082379141, 37991.810040950724, 33728.0, 33861.49207761935, 34754.30491390209, 34824.47763283603, 35472.822635887685, 24585.0, 25601.871990639927, 25749.613755793303, 25988.0, 26448.8677556611], "unit": "score", "name": "ext.html", "value": 20603.539977424352}, {"lowerIsBetter": false, "replicates": [335.76047761431255, 360.7510817535901, 371.53929127881435, 382.64031810098504, 393.6181903553552, 17215.569610759707, 20072.59854802903, 20773.792262077375, 20974.32205423566, 21109.472263193427, 20149.891755953417, 20539.691904621443, 21160.0, 21195.682064769004, 22236.110555577758, 5805.15825205346, 5976.611520251192, 5978.252718410199, 6018.548608854331, 6030.969845150768, 4372.5627437256335, 4398.208322501949, 4571.679982401233, 6441.516886233528, 6463.192100987377, 6363.459105975998, 6392.360763923593, 6396.808095757112, 6399.168108145957, 6414.711337989778, 5739.655620662774, 6005.789797357115, 6015.218021657157, 6019.5184385249295, 6377.681115944208, 4012.6789856811383, 4650.4186976627925, 5726.284214473191, 5751.4536119068625, 5765.990951583498, 13509.662258443519, 13737.587872363845, 13951.0, 13980.440782368692, 14391.280435978158, 2138.5402138540135, 2170.858894171874, 2351.5179388225374, 2372.79831214347, 2805.9017934372405, 9942.850857237147, 10025.949870250603, 10162.745931351701, 10572.207084468695, 10613.097886679641, 1779.6084861330487, 1800.4238643634042, 1807.1145138881852, 1845.0866820923595, 1848.02978436322, 80861.0, 113740.43129784298, 115244.0, 117968.0, 119671.20493192523, 9470.195033422098, 11977.341246231366, 11994.700132496757, 12032.037437005194, 12161.5135394585, 14505.202213878127, 14537.418503259963, 14550.4907328243, 14569.490067847786, 14575.0, 8755.299576033902, 9024.729258122135, 9026.007139214682, 9085.727428177166, 9123.543822808833, 9245.306602004743, 9280.72157835266, 9282.675106371245, 9359.204467620328, 9362.391444556082, 4620.653450991189, 4701.0, 4708.929366059512, 4709.434867815816, 4737.242041273448, 1946.3966170487195, 1975.2494052260336, 1991.412533302679, 1993.1130646862298, 1998.6302534031252, 913.5386629751932, 992.2905122837207, 992.503748125937, 1023.8873723890515, 1096.5065720425841, 20654.17383304681, 21097.367078987656, 21273.468163295733, 21309.573808523743, 21339.35981920514, 972.397113789455, 1029.893867041901, 1034.9016843399866, 1082.1072615092423, 1085.2132204152085, 9252.213561847184, 10894.727631809268, 11322.264052836705, 11476.311421314747, 11510.539578416938, 275384.0, 626422.8678856577, 658352.0, 658479.4152058514, 673589.0, 99051.50474247582, 109784.9999999984, 116942.0, 118339.40830295793, 122798.0, 1028.1106842581114, 1032.8037672842136, 1055.1400608504046, 1056.6248981611418, 1056.6777132974516, 15538.378464861278, 17930.372436964644, 18108.547286317946, 18181.272749089887, 19098.7135192975, 53417.46582534125, 54606.72696636491, 54949.72525137509, 55714.88570228654, 55783.0, 74670.87993680208, 76916.61541692256, 77628.22371776435, 79484.0, 80043.3991320182, 8074.111847696631, 8235.13531079228, 8270.297024752723, 8310.127436619068, 8603.956980215058, 9589.664361747306, 10571.471426428801, 11449.59926402572, 13834.031617786659, 14092.084014539023, 10530.526126324181, 11629.127815414047, 11696.70758231051, 11754.412279385826, 12142.053832504294, 7521.168522332676, 8158.0, 11678.299302041905, 11769.882301176878, 12050.819237711266, 12029.398530073637, 12057.138003567195, 12223.388830558615, 12377.195482293622, 12391.318477483825, 8521.701740439055, 8645.827083458422, 8658.350623703373, 8722.302215822845, 8771.122887711177, 8761.211490965843, 11253.88746112561, 11980.221285616408, 12074.335911524951, 12134.696632584257], "unit": "score", "name": "jquery.html", "value": 9485.861948542237}, {"lowerIsBetter": false, "replicates": [1418.5744276716985, 1472.5655931500207, 1625.544847442716, 1882.9905850470745, 2058.588282343531, 8103.432759706823, 8727.214550690436, 8894.421862578927, 8909.376343655947, 8935.463872167675, 8651.04838467768, 8894.510801905893, 8901.465912045265, 8901.866472002925, 8903.688370907019, 2537.89848406064, 2563.6410902473667, 2566.974330256692, 2567.82025258232, 2568.743125687435, 2506.624006399046, 2565.3586603349163, 2567.101514469939, 2569.7301783312764, 2572.5626643470655, 2388.904443822245, 2493.5386953413586, 2512.309114993373, 2512.949741005179, 2513.28371414147, 2545.0456078970387, 2569.0366112707734, 2572.794176465878, 2576.703679076902, 2579.445419234855, 2529.886155123024, 2565.1534993452115, 2572.5626643470655, 2573.6396904433395, 2578.7292334304816, 8945.64217431302, 9018.008019117891, 9025.05236950124, 9027.954860225656, 9043.502607356593, 5279.392869819982, 5399.649022813504, 5415.83752487426, 5451.3458384993655, 5453.972730136364, 3614.150674591469, 3712.257548490286, 3747.625237476258, 3766.8681596144, 3776.8300426480873, 919.4161707315835, 1046.2414749306768, 1070.2133931560297, 1080.6109800471825, 1099.8240281554913, 12348.38258087092, 12370.257784532867, 12371.876281237252, 12379.566715164927, 12393.442295096742, 4853.02939412119, 4934.777934992934, 4992.350994370709, 4993.101241776442, 5008.424031236382, 10332.741681457874, 10346.430946297874, 10350.948245258876, 10351.948240258902, 10354.585816567253, 5583.274174357308, 5585.916211256835, 5591.245181900473, 5601.775928962796, 5628.352739435018, 4540.228161212602, 4615.192341340252, 4860.8784780380065, 4985.925211121836, 5111.258867464197, 3974.5627980922077, 4045.110075783382, 4051.230266249403, 4079.3676980068135, 4103.671706263492, 1334.8798608125314, 1338.3040818774182, 1339.430741934674, 1357.5248662967883, 1368.609946165338, 1051.952662130206, 1087.1737479515466, 1186.9406529673481, 1353.1272329347712, 1454.2365258239297, 8143.511389316542, 8151.836963260702, 8253.298469630148, 8289.0, 8291.461055031403, 1038.5793753529833, 1232.039009572535, 1232.4761976160096, 1255.0461649146714, 1267.6070418170398, 6258.405451482102, 6295.905561416583, 6371.617702937839, 6374.872502549923, 6376.872462550723, 10458.26792124544, 10893.237473376947, 10912.836307455394, 10984.340939543654, 10996.28524145928, 10575.153987680967, 10637.840432393521, 10800.891991080145, 10868.347899126078, 10882.347059176474, 8377.329813614897, 8488.702895398756, 8523.190296921783, 8545.529995850164, 8545.572721363907, 7967.681292748457, 7974.082980457321, 8029.07665618438, 8042.437029407885, 8132.105468398589, 9593.184579310837, 9801.9019809801, 9832.262580306362, 9851.556679949275, 9943.055409736064, 9845.901540984498, 10144.985501449795, 10157.288989770645, 10276.845847312446, 10320.0, 7480.775576732707, 7509.624518774149, 7591.202923692933, 7631.427642926692, 7705.30652241301, 8430.156984301766, 8468.237858592756, 8496.235338819535, 8504.40469167177, 8505.659773609234, 6526.902096468461, 6539.7384104637185, 7418.629068546443, 7457.477976541807, 7639.579823109782, 7436.888446673413, 7437.144728356092, 7458.328750412489, 7506.0, 7521.022267105242, 7842.64708088126, 7955.801104972422, 7959.482633628795, 7963.283304502623, 7978.601069946363, 7101.893471597827, 7111.6799744010605, 7196.8920466192, 7210.459215558749, 7216.639168041682, 7227.313405226495, 7293.671784769805, 7294.598797066213, 7304.123505179413, 7354.852902942018], "unit": "score", "name": "mootools.html", "value": 5054.195590374332}, {"lowerIsBetter": false, "replicates": [331.7578167937406, 337.0, 340.94374428219345, 341.2288228603356, 346.81445426696723, 6683.665816709164, 6689.8996515052195, 6701.765438209658, 6753.527253092286, 6793.150856142982, 6643.236027856798, 6650.933490665092, 6664.333566643333, 6673.966630166855, 6700.095487109239, 4308.3537469379535, 4496.168208881351, 4724.692894961834, 4951.356323677916, 4989.525995030484, 4962.007598480301, 4971.179755340365, 4981.078500477423, 4987.027529631723, 4999.8000079996755, 4929.309896614459, 4938.0, 4947.109520286347, 4950.381202349707, 4972.154733695263, 3938.6652134568594, 4674.859754207379, 4723.173444647173, 4939.259111133323, 4982.850514484571, 3475.391806433864, 4252.829886804524, 4288.656907447396, 4300.311950087971, 4300.333448315516, 4796.904061918742, 6371.52213583983, 6410.455111315544, 6504.869902601921, 6545.247296560861, 5119.59043276537, 5749.511291540224, 5849.181114643953, 5858.0, 5870.354261031283, 5710.0, 7046.295370462964, 7047.088865679546, 7062.470314726416, 7065.187503437068, 4398.560143985608, 4544.250198717207, 4555.840545580922, 4575.153596584642, 4578.2903649934315, 7197.748078817216, 7347.816304592375, 7403.481756277063, 7443.441741869327, 7452.329290363893, 4660.650451216173, 4667.136579732693, 4678.602318802872, 4684.531546845288, 4695.154872123051, 4743.952560474351, 4757.310190022427, 4757.5718185363485, 4757.833475828399, 4761.40482439695, 5601.60788744784, 5602.971985140048, 5611.438856114356, 5624.29696287964, 5631.4087020863035, 6807.897881531781, 7016.438684905195, 7043.0, 7046.964765176142, 7100.893486597705, 1635.942742004048, 1646.6788976149535, 1655.3047719957647, 1659.2035822805121, 1660.435451946344, 999.9450030248406, 1024.3137098144261, 1056.8467572201987, 1063.7819247054335, 1082.2640604389092, 6573.868522629521, 6713.429358504484, 6722.462203023746, 6726.596404215763, 6740.9662951685905, 7414.332710056121, 7418.851622967619, 7427.4800763946005, 7448.5158464699625, 7449.702011919462, 6667.099941507931, 6672.8999065013095, 6678.699458524378, 6687.866242675216, 6721.4958878084335, 3211.983940080331, 3792.543607816686, 3850.364689826203, 3905.6484916357094, 3922.7057970652313, 7575.2424757524905, 7718.884216736754, 7735.7679269622, 7736.690532378754, 7751.573663448565, 7553.395728341829, 7622.047244094489, 7622.161562228151, 7628.618569071524, 7636.732714354971, 6259.62442253448, 7703.075630924212, 7714.961425192838, 7725.7295994641045, 7743.728969486154, 5949.226600542075, 7058.082449281561, 7351.00761397226, 7373.889391659022, 7389.076365454318, 5883.499902508334, 7150.928490715234, 7178.0, 7182.569045857265, 7197.172325182671, 7725.690972361042, 7728.536287822749, 7763.68945242184, 7767.184445633353, 7775.961120194363, 4669.7431641260055, 4721.527847215251, 4733.881652958704, 4734.73958932262, 4745.240761478285, 7079.0, 7401.7039318428815, 7404.185539590749, 7415.147258065392, 7420.5176663516695, 7138.535995160506, 7176.174739904978, 7180.676869540779, 7180.74336991014, 7184.856302874018, 7097.574145551283, 7151.392131668867, 7152.856942861218, 7166.068411106523, 7186.353228209487, 6975.6163411012885, 6981.5112942093565, 6986.650667466504, 6987.790366289019, 7034.894476582753, 6942.49202842825, 7055.717771289091, 7137.892931605927, 7147.964260178665, 7154.320339567733, 6616.106825578485, 6833.521653484408, 6857.5199736019995, 7000.789976300719, 7013.929860701328], "unit": "score", "name": "prototype.html", "value": 5173.976995873646}, {"lowerIsBetter": false, "replicates": [678.7454704485817, 680.5304340005396, 692.9896051559226, 727.3926271563242, 729.4711334282642, 15070.020448670843, 15393.076415415055, 15429.0, 15461.994970326936, 15478.4582539611, 14399.568012959602, 14619.561413157622, 14632.0, 14633.487827926025, 14657.706845863077, 816.9468984516017, 820.9507429554216, 827.4910929778173, 968.7965527239288, 986.4870267460952, 816.1838161838161, 818.9918100818975, 960.6205548808216, 982.5578489679637, 985.1675334342469, 1050.2648146297622, 1054.098745572536, 1054.3621109228882, 1055.9915280906755, 1056.7410984308856, 1038.0709265207672, 1040.9479526023667, 1041.0162396535277, 1041.338749893823, 1042.880068792091, 628.2680677011322, 773.157258588136, 787.0830482487895, 789.1634867040955, 792.0890975378361, 15903.443379481778, 15945.441909533227, 15967.760483592756, 15998.96006759557, 16136.838631613768, 10949.562017519289, 12914.0, 12968.675783105404, 13319.53381631648, 13420.731585368336, 9831.557579908922, 10100.545475453622, 10170.847437288447, 10361.171106311476, 10389.116925061378, 3634.200475895299, 3665.541807274091, 3761.360568703327, 3785.1483416231404, 3907.8827635170705, 88163.55918220432, 88443.0, 88847.0, 89158.32525024259, 89426.55286723525, 9895.406275623485, 9961.40231586107, 9968.501574921225, 10413.062824345694, 10777.461126943621, 23830.285091447284, 23852.88073559656, 23899.641505377433, 23936.281911542683, 24245.0, 7912.802179945547, 7997.5601341925585, 8033.598320084089, 8071.112177660452, 8162.918370816215, 4194.664426845845, 4264.509581398117, 4305.763183024964, 4330.610245077895, 4331.090471001062, 3767.604401537854, 3813.0, 3814.237152569497, 3814.7138964577766, 3815.4086116651965, 684.9280825513349, 687.7042871565175, 691.1153723234269, 703.7888633409957, 707.734599525178, 581.7004242814953, 605.4036773777825, 609.8749756300036, 614.2628845385466, 635.7607987304675, 8245.257926786619, 8260.380471464665, 8310.318106856867, 8381.916180838236, 8439.198276163756, 590.6574186971546, 596.1207219351509, 625.1872565664618, 626.5614070150913, 635.9872802543923, 3821.426785982125, 3891.2606604745006, 3912.941305880414, 3984.30274701926, 4076.735012224196, 96975.51512242394, 98073.50963245281, 98455.50772246237, 99367.50316248373, 99409.50295248478, 83064.0, 84733.72899406514, 85389.57305213559, 85633.0, 85951.57024214839, 75437.99999999891, 75497.6225118871, 75546.0, 76601.0, 77286.61356693292, 7779.988601481771, 7993.0, 8017.879731804144, 8052.597370131352, 8244.793880153044, 40534.594654054265, 53146.468535314154, 53381.19928201003, 53553.464465354846, 53606.73196633992, 70045.29954700387, 75597.24402755902, 76224.0, 76248.61875690808, 76983.2301676976, 10389.116925061455, 10414.0, 10515.474226288808, 10577.471126443801, 11134.053605443629, 10756.0, 10782.029617334478, 10959.287646302964, 11085.22403431752, 11750.059995200534, 10478.423686697304, 10661.520231589442, 10663.520141593492, 10745.194110441591, 11969.461374238006, 11459.36973466434, 11575.363355015555, 11633.0, 11753.118516111497, 11878.168528202943, 11355.37545435009, 11408.885911140782, 11564.13269004845, 12013.939930300292, 12046.277223366276, 9530.475823829756, 9701.757456063655, 10009.199264059003, 10089.243306751876, 10286.228532859916, 7065.792891250998, 9476.810463790824, 9677.322587418814, 9683.225341972766, 9708.689476438429], "unit": "score", "name": "yui.html", "value": 7164.8278978695}], "name": "dromaeo_css", "value": 7716.9532616861425}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 110.0, 111.0, 111.0, 111.0, 120.0, 110.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [152.0, 119.0, 143.0, 180.0, 149.0, 139.0, 115.0, 152.0, 145.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 141.1}, {"lowerIsBetter": true, "replicates": [188.0, 182.0, 181.0, 187.0, 187.0, 185.0, 184.0, 184.0, 185.0, 184.0], "unit": "score", "name": "audio-dft", "value": 184.7}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 73.0, 117.0, 55.0, 55.0, 58.0, 57.0, 118.0, 53.0], "unit": "score", "name": "audio-fft", "value": 73.7}, {"lowerIsBetter": true, "replicates": [89.0, 95.0, 128.0, 80.0, 78.0, 84.0, 116.0, 76.0, 79.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 94.1}, {"lowerIsBetter": true, "replicates": [93.0, 130.0, 88.0, 84.0, 87.0, 84.0, 88.0, 84.0, 88.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.2}, {"lowerIsBetter": true, "replicates": [143.0, 93.0, 92.0, 92.0, 91.0, 92.0, 92.0, 92.0, 92.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 97.1}, {"lowerIsBetter": true, "replicates": [86.0, 90.0, 84.0, 84.0, 85.0, 84.0, 84.0, 87.0, 85.0, 81.0], "unit": "score", "name": "imaging-desaturate", "value": 85.0}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 58.0, 57.0, 57.0, 58.0, 57.0, 67.0, 54.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [64.0, 62.0, 69.0, 66.0, 76.0, 71.0, 66.0, 66.0, 65.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [80.0, 79.0, 80.0, 81.0, 79.0, 80.0, 91.0, 103.0, 104.0, 107.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.4}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 117.0, 122.0, 128.0, 115.0, 119.0, 130.0, 129.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.4}, {"lowerIsBetter": true, "replicates": [132.0, 120.0, 131.0, 132.0, 132.0, 118.0, 155.0, 166.0, 146.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.4}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 66.0, 65.0, 64.0, 66.0, 67.0, 67.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.6}], "name": "kraken", "value": 1415.7}]} 02:47:10 INFO - Return code: 0 02:47:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:47:10 INFO - # TBPL SUCCESS # 02:47:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:47:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:47:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:47:10 INFO - 2016-03-16 02:47:10.736 screenresolution[1682:9915] starting screenresolution argv=screenresolution get 02:47:10 INFO - 2016-03-16 02:47:10.739 screenresolution[1682:9915] Display 0: 1600x1200x32@60 02:47:10 INFO - 2016-03-16 02:47:10.745 screenresolution[1683:9918] starting screenresolution argv=screenresolution list 02:47:10 INFO - Available Modes on Display 0 02:47:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:47:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:47:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:47:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:47:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:47:10 INFO - Intel Iris: 02:47:10 INFO - Chipset Model: Intel Iris 02:47:10 INFO - Type: GPU 02:47:10 INFO - Bus: Built-In 02:47:10 INFO - VRAM (Dynamic, Max): 1536 MB 02:47:10 INFO - Vendor: Intel (0x8086) 02:47:10 INFO - Device ID: 0x0a2e 02:47:10 INFO - Revision ID: 0x0009 02:47:10 INFO - Displays: 02:47:10 INFO - Display: 02:47:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:47:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:47:10 INFO - Display Serial Number: 1600x1200 60 02:47:10 INFO - Main Display: Yes 02:47:10 INFO - Mirror: Off 02:47:10 INFO - Online: Yes 02:47:10 INFO - Rotation: Supported 02:47:10 INFO - Return code: 0 02:47:10 INFO - Running post-action listener: _resource_record_post_action 02:47:10 INFO - Running post-run listener: _resource_record_post_run 02:47:12 INFO - Total resource usage - Wall time: 1203s; CPU: 52.0%; Read bytes: 31972864; Write bytes: 664152064; Read time: 318; Write time: 1785 02:47:12 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 361415168; Write bytes: 363214848; Read time: 28246; Write time: 693 02:47:12 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 30191104; Write bytes: 299442176; Read time: 301; Write time: 1087 02:47:12 INFO - Running post-run listener: _upload_blobber_files 02:47:12 INFO - Blob upload gear active. 02:47:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:47:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:47:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:47:12 INFO - (blobuploader) - INFO - Open directory for files ... 02:47:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:47:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:47:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:47:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:47:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:47:13 INFO - (blobuploader) - INFO - Done attempting. 02:47:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:47:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:47:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:47:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:47:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:47:14 INFO - (blobuploader) - INFO - Done attempting. 02:47:14 INFO - (blobuploader) - INFO - Iteration through files over. 02:47:14 INFO - Return code: 0 02:47:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:47:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:47:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bba9256faf2827fa091bb4f04167d5dc598ce3386a8aa7af5dd2677b5a5fa2118df7cd5b30826d2aecdc68c1aed5fded9fdd13a3c103652d079403fd2032002d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0a037a29f4bba95b39cdd983d96481b738be7b3659a25714c93555cf89428c6e5c0f4972f099bbfd47210b2bcd77c04729fba33a01dea200a9fdf1bf12f56bf"} 02:47:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:47:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:47:14 INFO - Contents: 02:47:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bba9256faf2827fa091bb4f04167d5dc598ce3386a8aa7af5dd2677b5a5fa2118df7cd5b30826d2aecdc68c1aed5fded9fdd13a3c103652d079403fd2032002d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0a037a29f4bba95b39cdd983d96481b738be7b3659a25714c93555cf89428c6e5c0f4972f099bbfd47210b2bcd77c04729fba33a01dea200a9fdf1bf12f56bf"} 02:47:14 INFO - Running post-run listener: copy_logs_to_upload_dir 02:47:14 INFO - Copying logs to upload dir... 02:47:14 INFO - mkdir: /builds/slave/test/build/upload/logs 02:47:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.671199 ========= master_lag: 8.62 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-03-16 02:47:19.065604) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 7 secs) (at 2016-03-16 02:47:19.069312) ========= 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.QyiU4Yqo38/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.RLiyTZVeyQ/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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/bba9256faf2827fa091bb4f04167d5dc598ce3386a8aa7af5dd2677b5a5fa2118df7cd5b30826d2aecdc68c1aed5fded9fdd13a3c103652d079403fd2032002d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0a037a29f4bba95b39cdd983d96481b738be7b3659a25714c93555cf89428c6e5c0f4972f099bbfd47210b2bcd77c04729fba33a01dea200a9fdf1bf12f56bf"} build_url:https://queue.taskcluster.net/v1/task/EkHZqGmJTU6zgznUDxXoJg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011187 build_url: 'https://queue.taskcluster.net/v1/task/EkHZqGmJTU6zgznUDxXoJg/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/bba9256faf2827fa091bb4f04167d5dc598ce3386a8aa7af5dd2677b5a5fa2118df7cd5b30826d2aecdc68c1aed5fded9fdd13a3c103652d079403fd2032002d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0a037a29f4bba95b39cdd983d96481b738be7b3659a25714c93555cf89428c6e5c0f4972f099bbfd47210b2bcd77c04729fba33a01dea200a9fdf1bf12f56bf"}' ========= master_lag: 7.40 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 7 secs) (at 2016-03-16 02:47:26.483173) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 9 secs) (at 2016-03-16 02:47:26.483459) ========= 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.QyiU4Yqo38/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.RLiyTZVeyQ/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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.005370 ========= master_lag: 9.31 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 9 secs) (at 2016-03-16 02:47:35.803207) ========= ========= Started reboot skipped (results: 3, elapsed: 6 secs) (at 2016-03-16 02:47:35.803477) ========= ========= Finished reboot skipped (results: 3, elapsed: 6 secs) (at 2016-03-16 02:47:42.311135) ========= ========= Total master_lag: 39.03 =========