builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0108 starttime: 1458853734.85 results: success (0) buildid: 20160324121213 builduid: 4dcba4b4c64d484da9fdb28954460ae8 revision: aadf5e15faf8ba88b48d16bb396f115816b8f673 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 14:08:54.850483) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 14:08:54.854019) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 14:08:54.854367) ========= 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.kBG0atjFJJ/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.N8X1sbZ8Xa/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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.005742 basedir: '/builds/slave/test' ========= master_lag: 0.12 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 14:08:54.978325) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 14:08:54.978642) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 14:08:55.215923) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 14:08:55.216340) ========= 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.kBG0atjFJJ/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.N8X1sbZ8Xa/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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.005259 ========= master_lag: 0.17 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 14:08:55.394098) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 14:08:55.394416) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 14:08:55.394774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 14:08:55.395065) ========= 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.kBG0atjFJJ/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.N8X1sbZ8Xa/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-24 14:08:55-- 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% 9.35M=0.001s 2016-03-24 14:08:55 (9.35 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.418737 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 14:08:55.890162) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 14:08:55.890478) ========= 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.kBG0atjFJJ/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.N8X1sbZ8Xa/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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.019865 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 14:08:56.045125) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-03-24 14:08:56.045476) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev aadf5e15faf8ba88b48d16bb396f115816b8f673 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev aadf5e15faf8ba88b48d16bb396f115816b8f673 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kBG0atjFJJ/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.N8X1sbZ8Xa/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-24 14:08:56,150 truncating revision to first 12 chars 2016-03-24 14:08:56,150 Setting DEBUG logging. 2016-03-24 14:08:56,150 attempt 1/10 2016-03-24 14:08:56,150 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/aadf5e15faf8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-24 14:08:58,072 unpacking tar archive at: fx-team-aadf5e15faf8/testing/mozharness/ program finished with exit code 0 elapsedTime=2.535030 ========= master_lag: 3.63 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-03-24 14:09:02.207219) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 14:09:02.207569) ========= echo aadf5e15faf8ba88b48d16bb396f115816b8f673 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'aadf5e15faf8ba88b48d16bb396f115816b8f673'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kBG0atjFJJ/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.N8X1sbZ8Xa/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 aadf5e15faf8ba88b48d16bb396f115816b8f673 program finished with exit code 0 elapsedTime=0.004937 script_repo_revision: 'aadf5e15faf8ba88b48d16bb396f115816b8f673' ========= master_lag: 0.29 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 14:09:02.501348) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 14:09:02.501655) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 14:09:03.110605) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 26 secs) (at 2016-03-24 14:09:03.110996) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kBG0atjFJJ/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.N8X1sbZ8Xa/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 14:09:03 INFO - MultiFileLogger online at 20160324 14:09:03 in /builds/slave/test 14:09:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:09:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:09:03 INFO - {'append_to_log': False, 14:09:03 INFO - 'base_work_dir': '/builds/slave/test', 14:09:03 INFO - 'blob_upload_branch': 'Fx-Team', 14:09:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:09:03 INFO - 'branch': 'Fx-Team', 14:09:03 INFO - 'buildbot_json_path': 'buildprops.json', 14:09:03 INFO - 'config_files': ('talos/mac_config.py',), 14:09:03 INFO - 'default_actions': ('clobber', 14:09:03 INFO - 'read-buildbot-config', 14:09:03 INFO - 'download-and-extract', 14:09:03 INFO - 'populate-webroot', 14:09:03 INFO - 'create-virtualenv', 14:09:03 INFO - 'install', 14:09:03 INFO - 'run-tests'), 14:09:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:09:03 INFO - 'download_minidump_stackwalk': True, 14:09:03 INFO - 'download_symbols': 'ondemand', 14:09:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:09:03 INFO - 'tooltool.py': '/tools/tooltool.py', 14:09:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:09:03 INFO - '/tools/misc-python/virtualenv.py')}, 14:09:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:09:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:09:03 INFO - 'installer_path': 'installer.exe', 14:09:03 INFO - 'log_level': 'info', 14:09:03 INFO - 'log_name': 'talos', 14:09:03 INFO - 'log_to_console': True, 14:09:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:09:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:09:03 INFO - 'opt_config_files': (), 14:09:03 INFO - 'pip_index': False, 14:09:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:09:03 INFO - 'cmd': ('bash', 14:09:03 INFO - '-c', 14:09:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:09:03 INFO - 'enabled': True, 14:09:03 INFO - 'halt_on_failure': False, 14:09:03 INFO - 'name': 'check_screen_resolution'},), 14:09:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:09:03 INFO - 'cmd': ('bash', 14:09:03 INFO - '-c', 14:09:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:09:03 INFO - 'enabled': True, 14:09:03 INFO - 'halt_on_failure': False, 14:09:03 INFO - 'name': 'check_screen_resolution'},), 14:09:03 INFO - 'run_cmd_checks_enabled': True, 14:09:03 INFO - 'sps_profile': False, 14:09:03 INFO - 'sps_profile_interval': 0, 14:09:03 INFO - 'suite': 'dromaeojs', 14:09:03 INFO - 'system_bits': '32', 14:09:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:09:03 INFO - 'title': 't-yosemite-r7-0108', 14:09:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:09:03 INFO - 'use_talos_json': True, 14:09:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:09:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:09:03 INFO - 'work_dir': 'build'} 14:09:03 INFO - ##### 14:09:03 INFO - ##### Running clobber step. 14:09:03 INFO - ##### 14:09:03 INFO - Running pre-action listener: _resource_record_pre_action 14:09:03 INFO - Running main action method: clobber 14:09:03 INFO - rmtree: /builds/slave/test/build 14:09:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:09:04 INFO - Running post-action listener: _resource_record_post_action 14:09:04 INFO - ##### 14:09:04 INFO - ##### Running read-buildbot-config step. 14:09:04 INFO - ##### 14:09:04 INFO - Running pre-action listener: _resource_record_pre_action 14:09:04 INFO - Running main action method: read_buildbot_config 14:09:04 INFO - Using buildbot properties: 14:09:04 INFO - { 14:09:04 INFO - "project": "", 14:09:04 INFO - "product": "firefox", 14:09:04 INFO - "script_repo_revision": "production", 14:09:04 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 14:09:04 INFO - "repository": "", 14:09:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 14:09:04 INFO - "buildid": "20160324121213", 14:09:04 INFO - "pgo_build": "False", 14:09:04 INFO - "basedir": "/builds/slave/test", 14:09:04 INFO - "buildnumber": 554, 14:09:04 INFO - "slavename": "t-yosemite-r7-0108", 14:09:04 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:09:04 INFO - "platform": "yosemite_r7", 14:09:04 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:09:04 INFO - "branch": "fx-team", 14:09:04 INFO - "repo_path": "integration/fx-team", 14:09:04 INFO - "revision": "aadf5e15faf8ba88b48d16bb396f115816b8f673", 14:09:04 INFO - "stage_platform": "macosx64", 14:09:04 INFO - "builduid": "4dcba4b4c64d484da9fdb28954460ae8", 14:09:04 INFO - "slavebuilddir": "test" 14:09:04 INFO - } 14:09:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 14:09:04 INFO - Running post-action listener: _resource_record_post_action 14:09:04 INFO - ##### 14:09:04 INFO - ##### Running download-and-extract step. 14:09:04 INFO - ##### 14:09:04 INFO - Running pre-action listener: _resource_record_pre_action 14:09:04 INFO - Running main action method: download_and_extract 14:09:04 INFO - mkdir: /builds/slave/test/build/tests 14:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:04 INFO - https://queue.taskcluster.net/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:09:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 14:09:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 14:09:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 14:09:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 14:09:06 INFO - Downloaded 1199 bytes. 14:09:06 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 14:09:06 INFO - Using the following test package requirements: 14:09:06 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 14:09:06 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:09:06 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 14:09:06 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:09:06 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 14:09:06 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:09:06 INFO - u'jsshell-mac.zip'], 14:09:06 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:09:06 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 14:09:06 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 14:09:06 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:09:06 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 14:09:06 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:09:06 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 14:09:06 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:09:06 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 14:09:06 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:09:06 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 14:09:06 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:06 INFO - https://queue.taskcluster.net/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:09:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:09:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:09:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:09:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:09:17 INFO - Downloaded 17926949 bytes. 14:09:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:09:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:09:20 INFO - Return code: 0 14:09:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:20 INFO - https://queue.taskcluster.net/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:09:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:09:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:09:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:09:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:09:24 INFO - Downloaded 17926949 bytes. 14:09:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:09:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:09:28 INFO - Return code: 0 14:09: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')]} 14:09:28 INFO - https://queue.taskcluster.net/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:09:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:09:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:09:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:09:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:09:41 INFO - Downloaded 10847187 bytes. 14:09:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:09:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:09:41 INFO - Return code: 0 14:09: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')]} 14:09:41 INFO - https://queue.taskcluster.net/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:09:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:09:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:09:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 14:09:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 14:10:04 INFO - Downloaded 111327237 bytes. 14:10:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:10:04 INFO - mkdir: /builds/slave/test/properties 14:10:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:10:04 INFO - Writing to file /builds/slave/test/properties/build_url 14:10:04 INFO - Contents: 14:10:04 INFO - build_url:https://queue.taskcluster.net/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:10:16 INFO - Running post-action listener: _resource_record_post_action 14:10:16 INFO - Running post-action listener: set_extra_try_arguments 14:10:16 INFO - ##### 14:10:16 INFO - ##### Running populate-webroot step. 14:10:16 INFO - ##### 14:10:16 INFO - Running pre-action listener: _resource_record_pre_action 14:10:16 INFO - Running main action method: populate_webroot 14:10:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:10:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:10:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:10:16 INFO - '--tppagecycles', 14:10:16 INFO - '7'], 14:10:16 INFO - 'tests': ['tsvgm']}}, 14:10:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:10:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:10:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:10:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:10:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:10:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:10:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:16 INFO - 'talos_options': ['--e10s'], 14:10:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:16 INFO - 'tests': ['damp', 'tps']}, 14:10:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:16 INFO - 'talos_options': ['--e10s'], 14:10:16 INFO - 'tests': ['damp', 'tps']}, 14:10:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:10:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:10:16 INFO - 'other': {'tests': ['a11yr', 14:10:16 INFO - 'ts_paint', 14:10:16 INFO - 'tpaint', 14:10:16 INFO - 'sessionrestore', 14:10:16 INFO - 'sessionrestore_no_auto_restore', 14:10:16 INFO - 'tabpaint']}, 14:10:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:10:16 INFO - 'tests': ['a11yr', 14:10:16 INFO - 'ts_paint', 14:10:16 INFO - 'tpaint', 14:10:16 INFO - 'sessionrestore', 14:10:16 INFO - 'sessionrestore_no_auto_restore', 14:10:16 INFO - 'tabpaint']}, 14:10:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:10:16 INFO - 'tests': ['a11yr', 14:10:16 INFO - 'ts_paint', 14:10:16 INFO - 'tpaint', 14:10:16 INFO - 'sessionrestore', 14:10:16 INFO - 'sessionrestore_no_auto_restore', 14:10:16 INFO - 'tabpaint']}, 14:10:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:10:16 INFO - 'tests': ['a11yr', 14:10:16 INFO - 'ts_paint', 14:10:16 INFO - 'tpaint', 14:10:16 INFO - 'sessionrestore', 14:10:16 INFO - 'sessionrestore_no_auto_restore', 14:10:16 INFO - 'tabpaint']}, 14:10:16 INFO - 'other_l64': {'tests': ['a11yr', 14:10:16 INFO - 'ts_paint', 14:10:16 INFO - 'tpaint', 14:10:16 INFO - 'sessionrestore', 14:10:16 INFO - 'sessionrestore_no_auto_restore', 14:10:16 INFO - 'tabpaint']}, 14:10:16 INFO - 'other_nol64': {'tests': ['a11yr', 14:10:16 INFO - 'ts_paint', 14:10:16 INFO - 'tpaint', 14:10:16 INFO - 'sessionrestore', 14:10:16 INFO - 'sessionrestore_no_auto_restore', 14:10:16 INFO - 'tabpaint']}, 14:10:16 INFO - 'svgr': {'tests': ['tsvgx', 14:10:16 INFO - 'tsvgr_opacity', 14:10:16 INFO - 'tart', 14:10:16 INFO - 'tscrollx', 14:10:16 INFO - 'cart']}, 14:10:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:10:16 INFO - 'tests': ['tsvgx', 14:10:16 INFO - 'tsvgr_opacity', 14:10:16 INFO - 'tart', 14:10:16 INFO - 'tscrollx', 14:10:16 INFO - 'cart']}, 14:10:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:16 INFO - 'tests': ['tp5o']}, 14:10:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:16 INFO - 'talos_options': ['--e10s'], 14:10:16 INFO - 'tests': ['tp5o']}, 14:10:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:16 INFO - 'talos_options': ['--xperf_path', 14:10:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:10:16 INFO - 'tests': ['tp5n']}, 14:10:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:16 INFO - 'talos_options': ['--e10s', 14:10:16 INFO - '--xperf_path', 14:10:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:10:16 INFO - 'tests': ['tp5n']}}, 14:10:16 INFO - 'talos.zip': {'path': '', 14:10:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:10:16 INFO - Running post-action listener: _resource_record_post_action 14:10:16 INFO - ##### 14:10:16 INFO - ##### Running create-virtualenv step. 14:10:16 INFO - ##### 14:10:16 INFO - Running pre-action listener: _resource_record_pre_action 14:10:16 INFO - Running main action method: create_virtualenv 14:10:16 INFO - Creating virtualenv /builds/slave/test/build/venv 14:10:16 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 14:10:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:10:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:10:16 INFO - Using real prefix '/tools/python27' 14:10:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:10:16 INFO - Installing distribute.............................................................................................................................................................................................done. 14:10:19 INFO - Installing pip.................done. 14:10:19 INFO - Return code: 0 14:10:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:10:19 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')]} 14:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:19 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')]} 14:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:19 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 0x107f6fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f7f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ae8c77010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e0ee00>, '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 0x107c37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e09b20>, '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.kBG0atjFJJ/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.N8X1sbZ8Xa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 14:10:19 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 14:10:19 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 14:10:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kBG0atjFJJ/Render', 14:10:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:19 INFO - 'HOME': '/Users/cltbld', 14:10:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:19 INFO - 'LOGNAME': 'cltbld', 14:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:19 INFO - 'MOZ_NO_REMOTE': '1', 14:10:19 INFO - 'NO_EM_RESTART': '1', 14:10:19 INFO - 'PAGER': '/bin/cat', 14:10:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:19 INFO - 'PWD': '/builds/slave/test', 14:10:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:19 INFO - 'SHELL': '/bin/bash', 14:10:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N8X1sbZ8Xa/Listeners', 14:10:19 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 14:10:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:19 INFO - 'USER': 'cltbld', 14:10:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:19 INFO - 'XPC_FLAGS': '0x0', 14:10:19 INFO - 'XPC_SERVICE_NAME': '0', 14:10:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:20 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 14:10:20 INFO - Cleaning up... 14:10:20 INFO - Return code: 0 14:10:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107f6fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f7f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ae8c77010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e0ee00>, '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 0x107c37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e09b20>, '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.kBG0atjFJJ/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.N8X1sbZ8Xa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 14:10:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:10:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:10:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kBG0atjFJJ/Render', 14:10:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:20 INFO - 'HOME': '/Users/cltbld', 14:10:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:20 INFO - 'LOGNAME': 'cltbld', 14:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:20 INFO - 'MOZ_NO_REMOTE': '1', 14:10:20 INFO - 'NO_EM_RESTART': '1', 14:10:20 INFO - 'PAGER': '/bin/cat', 14:10:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:20 INFO - 'PWD': '/builds/slave/test', 14:10:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:20 INFO - 'SHELL': '/bin/bash', 14:10:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N8X1sbZ8Xa/Listeners', 14:10:20 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 14:10:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:20 INFO - 'USER': 'cltbld', 14:10:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:20 INFO - 'XPC_FLAGS': '0x0', 14:10:20 INFO - 'XPC_SERVICE_NAME': '0', 14:10:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:20 INFO - Downloading/unpacking psutil>=0.7.1 14:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:10:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:25 INFO - Installing collected packages: psutil 14:10:25 INFO - Running setup.py install for psutil 14:10:25 INFO - building 'psutil._psutil_osx' extension 14:10:25 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 14:10:26 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 14:10:26 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 14:10:26 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 14:10:26 INFO - building 'psutil._psutil_posix' extension 14:10:26 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 14:10:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:10:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:10:26 INFO - ^ 14:10:26 INFO - 1 warning generated. 14:10:26 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 14:10:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:26 INFO - Successfully installed psutil 14:10:26 INFO - Cleaning up... 14:10:26 INFO - Return code: 0 14:10:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:10: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')]} 14:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:26 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 0x107f6fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f7f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ae8c77010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e0ee00>, '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 0x107c37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e09b20>, '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.kBG0atjFJJ/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.N8X1sbZ8Xa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 14:10:26 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 14:10:26 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 14:10:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kBG0atjFJJ/Render', 14:10:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:26 INFO - 'HOME': '/Users/cltbld', 14:10:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:26 INFO - 'LOGNAME': 'cltbld', 14:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:26 INFO - 'MOZ_NO_REMOTE': '1', 14:10:26 INFO - 'NO_EM_RESTART': '1', 14:10:26 INFO - 'PAGER': '/bin/cat', 14:10:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:26 INFO - 'PWD': '/builds/slave/test', 14:10:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:26 INFO - 'SHELL': '/bin/bash', 14:10:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N8X1sbZ8Xa/Listeners', 14:10:26 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 14:10:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:26 INFO - 'USER': 'cltbld', 14:10:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:26 INFO - 'XPC_FLAGS': '0x0', 14:10:26 INFO - 'XPC_SERVICE_NAME': '0', 14:10:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:10:26 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 14:10:26 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 14:10:26 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 14:10:26 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 14:10:26 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 14:10:26 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 14:10:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:10:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:10:32 INFO - Installing collected packages: mozsystemmonitor 14:10:32 INFO - Running setup.py install for mozsystemmonitor 14:10:32 INFO - Successfully installed mozsystemmonitor 14:10:32 INFO - Cleaning up... 14:10:32 INFO - Return code: 0 14:10:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f6fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f7f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ae8c77010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e0ee00>, '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 0x107c37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e09b20>, '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.kBG0atjFJJ/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.N8X1sbZ8Xa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 14:10:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:10:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:10:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kBG0atjFJJ/Render', 14:10:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:32 INFO - 'HOME': '/Users/cltbld', 14:10:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:32 INFO - 'LOGNAME': 'cltbld', 14:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:32 INFO - 'MOZ_NO_REMOTE': '1', 14:10:32 INFO - 'NO_EM_RESTART': '1', 14:10:32 INFO - 'PAGER': '/bin/cat', 14:10:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:32 INFO - 'PWD': '/builds/slave/test', 14:10:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:32 INFO - 'SHELL': '/bin/bash', 14:10:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N8X1sbZ8Xa/Listeners', 14:10:32 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 14:10:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:32 INFO - 'USER': 'cltbld', 14:10:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:32 INFO - 'XPC_FLAGS': '0x0', 14:10:32 INFO - 'XPC_SERVICE_NAME': '0', 14:10:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:32 INFO - Downloading/unpacking blobuploader==1.2.4 14:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:38 INFO - Downloading blobuploader-1.2.4.tar.gz 14:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:10:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:10:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:10:40 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 14:10:40 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 14:10:40 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 14:10:40 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 14:10:40 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 14:10:40 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 14:10:40 INFO - Downloading docopt-0.6.1.tar.gz 14:10:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:10:40 INFO - Installing collected packages: blobuploader, requests, docopt 14:10:40 INFO - Running setup.py install for blobuploader 14:10:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:10:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:10:40 INFO - Running setup.py install for requests 14:10:41 INFO - Running setup.py install for docopt 14:10:41 INFO - Successfully installed blobuploader requests docopt 14:10:41 INFO - Cleaning up... 14:10:41 INFO - Return code: 0 14:10:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10: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')]} 14:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:41 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 0x107f6fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f7f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ae8c77010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e0ee00>, '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 0x107c37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e09b20>, '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.kBG0atjFJJ/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.N8X1sbZ8Xa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 14:10:41 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 14:10:41 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 14:10:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kBG0atjFJJ/Render', 14:10:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:41 INFO - 'HOME': '/Users/cltbld', 14:10:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:41 INFO - 'LOGNAME': 'cltbld', 14:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:41 INFO - 'MOZ_NO_REMOTE': '1', 14:10:41 INFO - 'NO_EM_RESTART': '1', 14:10:41 INFO - 'PAGER': '/bin/cat', 14:10:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:41 INFO - 'PWD': '/builds/slave/test', 14:10:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:41 INFO - 'SHELL': '/bin/bash', 14:10:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N8X1sbZ8Xa/Listeners', 14:10:41 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 14:10:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:41 INFO - 'USER': 'cltbld', 14:10:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:41 INFO - 'XPC_FLAGS': '0x0', 14:10:41 INFO - 'XPC_SERVICE_NAME': '0', 14:10:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:10:41 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-4dNbK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:10:41 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-YVNVPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:10:42 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-JMKNHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:10:42 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-5Tab1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:10:42 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-b_YRLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:10:42 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-GXmgBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:10:42 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-jRe3Y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:10:42 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-Bf3OPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:10:42 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-9I3LpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:10:42 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-8O5ytl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:10:42 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-MtxSnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:10:43 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-iAPaCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:10:43 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-GMsiIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:10:43 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-iU4GSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:43 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-dlKdG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:10:43 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-fTCqcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:10:43 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-611sPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:10:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:10:43 INFO - Running setup.py install for manifestparser 14:10:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:10:43 INFO - Running setup.py install for mozcrash 14:10:43 INFO - Running setup.py install for mozdebug 14:10:44 INFO - Running setup.py install for mozdevice 14:10:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:10:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:10:44 INFO - Running setup.py install for mozfile 14:10:44 INFO - Running setup.py install for mozhttpd 14:10:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:10:44 INFO - Running setup.py install for mozinfo 14:10:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:10:44 INFO - Running setup.py install for mozInstall 14:10:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:10:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:10:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:10:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:10:44 INFO - Running setup.py install for mozleak 14:10:44 INFO - Running setup.py install for mozlog 14:10:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:10:45 INFO - Running setup.py install for moznetwork 14:10:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:10:45 INFO - Running setup.py install for mozprocess 14:10:45 INFO - Running setup.py install for mozprofile 14:10:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:10:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:10:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:10:45 INFO - Running setup.py install for mozrunner 14:10:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:10:45 INFO - Running setup.py install for mozscreenshot 14:10:45 INFO - Running setup.py install for moztest 14:10:46 INFO - Running setup.py install for mozversion 14:10:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:10:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:10:46 INFO - Cleaning up... 14:10:46 INFO - Return code: 0 14:10:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10:46 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')]} 14:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:46 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')]} 14:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:46 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 0x107f6fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f7f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ae8c77010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e0ee00>, '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 0x107c37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e09b20>, '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.kBG0atjFJJ/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.N8X1sbZ8Xa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 14:10:46 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 14:10:46 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 14:10:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kBG0atjFJJ/Render', 14:10:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:46 INFO - 'HOME': '/Users/cltbld', 14:10:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:46 INFO - 'LOGNAME': 'cltbld', 14:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:46 INFO - 'MOZ_NO_REMOTE': '1', 14:10:46 INFO - 'NO_EM_RESTART': '1', 14:10:46 INFO - 'PAGER': '/bin/cat', 14:10:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:46 INFO - 'PWD': '/builds/slave/test', 14:10:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:46 INFO - 'SHELL': '/bin/bash', 14:10:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N8X1sbZ8Xa/Listeners', 14:10:46 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 14:10:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:46 INFO - 'USER': 'cltbld', 14:10:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:46 INFO - 'XPC_FLAGS': '0x0', 14:10:46 INFO - 'XPC_SERVICE_NAME': '0', 14:10:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:10:46 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-XmMuew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:10:46 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)) 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:10:46 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-iHd9zC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:10:46 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)) 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:10:46 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-R3TDye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:10:46 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)) 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:10:46 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-v9HOap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:10:46 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)) 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:10:46 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-9cCcMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:10:47 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)) 14:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:10:47 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-oOgn8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:10:47 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)) 14:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:10:47 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-ZQQ_XP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:10:47 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)) 14:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:10:47 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-EzJRfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:10:47 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)) 14:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:10:47 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-Dhw__3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:10:47 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)) 14:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:10:47 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-N15veI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:10:47 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)) 14:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:10:47 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-Zyz0bk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:10:47 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)) 14:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:10:47 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-VKNsQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:10:47 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)) 14:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:10:47 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-eZkMDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:10:47 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)) 14:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:10:47 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-SDBJUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:10:48 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)) 14:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:48 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-5t01wP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:48 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)) 14:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:10:48 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-LUYEJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:10:48 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)) 14:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:10:48 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-gRWNIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:10:48 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)) 14:10:48 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)) 14:10:48 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)) 14:10:48 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)) 14:10:48 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)) 14:10:48 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)) 14:10:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:10:48 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 14:10:48 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 14:10:48 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 14:10:48 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 14:10:48 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 14:10:48 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 14:10:56 INFO - Downloading blessings-1.6.tar.gz 14:10:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:10:56 INFO - Installing collected packages: blessings 14:10:56 INFO - Running setup.py install for blessings 14:10:56 INFO - Successfully installed blessings 14:10:56 INFO - Cleaning up... 14:10:56 INFO - Return code: 0 14:10:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:10:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:10:57 INFO - Reading from file tmpfile_stdout 14:10:57 INFO - Current package versions: 14:10:57 INFO - blessings == 1.6 14:10:57 INFO - blobuploader == 1.2.4 14:10:57 INFO - docopt == 0.6.1 14:10:57 INFO - manifestparser == 1.1 14:10:57 INFO - mozInstall == 1.12 14:10:57 INFO - mozcrash == 0.17 14:10:57 INFO - mozdebug == 0.1 14:10:57 INFO - mozdevice == 0.48 14:10:57 INFO - mozfile == 1.2 14:10:57 INFO - mozhttpd == 0.7 14:10:57 INFO - mozinfo == 0.9 14:10:57 INFO - mozleak == 0.1 14:10:57 INFO - mozlog == 3.1 14:10:57 INFO - moznetwork == 0.27 14:10:57 INFO - mozprocess == 0.22 14:10:57 INFO - mozprofile == 0.28 14:10:57 INFO - mozrunner == 6.11 14:10:57 INFO - mozscreenshot == 0.1 14:10:57 INFO - mozsystemmonitor == 0.0 14:10:57 INFO - moztest == 0.7 14:10:57 INFO - mozversion == 1.4 14:10:57 INFO - psutil == 3.1.1 14:10:57 INFO - requests == 1.2.3 14:10:57 INFO - wsgiref == 0.1.2 14:10:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10:57 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')]} 14:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:57 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')]} 14:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:57 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 0x107f6fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f7f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ae8c77010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e0ee00>, '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 0x107c37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e09b20>, '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.kBG0atjFJJ/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.N8X1sbZ8Xa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 14:10:57 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 14:10:57 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 14:10:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kBG0atjFJJ/Render', 14:10:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:57 INFO - 'HOME': '/Users/cltbld', 14:10:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:57 INFO - 'LOGNAME': 'cltbld', 14:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:57 INFO - 'MOZ_NO_REMOTE': '1', 14:10:57 INFO - 'NO_EM_RESTART': '1', 14:10:57 INFO - 'PAGER': '/bin/cat', 14:10:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:57 INFO - 'PWD': '/builds/slave/test', 14:10:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:57 INFO - 'SHELL': '/bin/bash', 14:10:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N8X1sbZ8Xa/Listeners', 14:10:57 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 14:10:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:57 INFO - 'USER': 'cltbld', 14:10:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:57 INFO - 'XPC_FLAGS': '0x0', 14:10:57 INFO - 'XPC_SERVICE_NAME': '0', 14:10:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:57 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)) 14:10:57 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)) 14:10:57 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)) 14:10:57 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)) 14:10:57 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)) 14:10:57 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)) 14:10:57 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)) 14:10:57 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)) 14:10:57 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)) 14:10:57 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)) 14:10:57 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)) 14:10:57 INFO - Cleaning up... 14:10:57 INFO - Return code: 0 14:10:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:10:57 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')]} 14:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:57 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')]} 14:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:57 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 0x107f6fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f7f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ae8c77010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e0ee00>, '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 0x107c37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e09b20>, '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.kBG0atjFJJ/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.N8X1sbZ8Xa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 14:10:57 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 14:10:57 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 14:10:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kBG0atjFJJ/Render', 14:10:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:57 INFO - 'HOME': '/Users/cltbld', 14:10:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:57 INFO - 'LOGNAME': 'cltbld', 14:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:57 INFO - 'MOZ_NO_REMOTE': '1', 14:10:57 INFO - 'NO_EM_RESTART': '1', 14:10:57 INFO - 'PAGER': '/bin/cat', 14:10:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:57 INFO - 'PWD': '/builds/slave/test', 14:10:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:57 INFO - 'SHELL': '/bin/bash', 14:10:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N8X1sbZ8Xa/Listeners', 14:10:57 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 14:10:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:57 INFO - 'USER': 'cltbld', 14:10:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:57 INFO - 'XPC_FLAGS': '0x0', 14:10:57 INFO - 'XPC_SERVICE_NAME': '0', 14:10:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:57 INFO - Downloading/unpacking jsonschema 14:10:57 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 14:10:57 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 14:10:57 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 14:10:57 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 14:10:57 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 14:10:57 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 14:11:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:11:05 INFO - Downloading/unpacking functools32 (from jsonschema) 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:05 INFO - Downloading functools32-3.2.3-2.tar.gz 14:11:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:11:06 INFO - warning: no files found matching '*.txt' 14:11:06 INFO - no previously-included directories found matching 'build' 14:11:06 INFO - no previously-included directories found matching 'dist' 14:11:06 INFO - no previously-included directories found matching '.git*' 14:11:06 INFO - Installing collected packages: jsonschema, functools32 14:11:06 INFO - Running setup.py install for functools32 14:11:06 INFO - warning: no files found matching '*.txt' 14:11:06 INFO - no previously-included directories found matching 'build' 14:11:06 INFO - no previously-included directories found matching 'dist' 14:11:06 INFO - no previously-included directories found matching '.git*' 14:11:06 INFO - Successfully installed jsonschema functools32 14:11:06 INFO - Cleaning up... 14:11:06 INFO - Return code: 0 14:11:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:06 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 0x107f6fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f7f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ae8c77010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e0ee00>, '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 0x107c37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e09b20>, '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.kBG0atjFJJ/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.N8X1sbZ8Xa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 14:11:06 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 14:11:06 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 14:11:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kBG0atjFJJ/Render', 14:11:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:06 INFO - 'HOME': '/Users/cltbld', 14:11:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:06 INFO - 'LOGNAME': 'cltbld', 14:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:06 INFO - 'MOZ_NO_REMOTE': '1', 14:11:06 INFO - 'NO_EM_RESTART': '1', 14:11:06 INFO - 'PAGER': '/bin/cat', 14:11:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:06 INFO - 'PWD': '/builds/slave/test', 14:11:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:06 INFO - 'SHELL': '/bin/bash', 14:11:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N8X1sbZ8Xa/Listeners', 14:11:06 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 14:11:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:06 INFO - 'USER': 'cltbld', 14:11:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:06 INFO - 'XPC_FLAGS': '0x0', 14:11:06 INFO - 'XPC_SERVICE_NAME': '0', 14:11:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:06 INFO - Downloading/unpacking flake8 14:11:06 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 14:11:06 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 14:11:06 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 14:11:06 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 14:11:06 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 14:11:06 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 14:11:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:11:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:11:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:11:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:11:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:11:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:11:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:11:16 INFO - no previously-included directories found matching 'docs/_build' 14:11:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:11:16 INFO - Running setup.py install for pep8 14:11:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:11:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:11:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:11:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:11:16 INFO - no previously-included directories found matching 'docs/_build' 14:11:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:11:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:11:16 INFO - Cleaning up... 14:11:16 INFO - Return code: 0 14:11:16 INFO - Running post-action listener: _resource_record_post_action 14:11:16 INFO - Running post-action listener: _start_resource_monitoring 14:11:16 INFO - Starting resource monitoring. 14:11:16 INFO - ##### 14:11:16 INFO - ##### Running install step. 14:11:16 INFO - ##### 14:11:16 INFO - Running pre-action listener: _resource_record_pre_action 14:11:16 INFO - Running main action method: install 14:11:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:17 INFO - Reading from file tmpfile_stdout 14:11:17 INFO - Detecting whether we're running mozinstall >=1.0... 14:11:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:11:17 INFO - Reading from file tmpfile_stdout 14:11:17 INFO - Output received: 14:11:17 INFO - Usage: mozinstall [options] installer 14:11:17 INFO - Options: 14:11:17 INFO - -h, --help show this help message and exit 14:11:17 INFO - -d DEST, --destination=DEST 14:11:17 INFO - Directory to install application into. [default: 14:11:17 INFO - "/builds/slave/test"] 14:11:17 INFO - --app=APP Application being installed. [default: firefox] 14:11:17 INFO - mkdir: /builds/slave/test/build/application 14:11:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:11:50 INFO - Reading from file tmpfile_stdout 14:11:50 INFO - Output received: 14:11:50 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:11:50 INFO - Running post-action listener: _resource_record_post_action 14:11:50 INFO - ##### 14:11:50 INFO - ##### Running run-tests step. 14:11:50 INFO - ##### 14:11:50 INFO - Running pre-action listener: _resource_record_pre_action 14:11:50 INFO - Running main action method: run_tests 14:11:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:11:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:11:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:11:50 INFO - 2016-03-24 14:11:50.691 screenresolution[2293:25323] starting screenresolution argv=screenresolution get 14:11:50 INFO - 2016-03-24 14:11:50.693 screenresolution[2293:25323] Display 0: 1600x1200x32@60 14:11:50 INFO - 2016-03-24 14:11:50.699 screenresolution[2294:25325] starting screenresolution argv=screenresolution list 14:11:50 INFO - Available Modes on Display 0 14:11:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:11:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:11:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:11:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:11:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:11:50 INFO - Intel Iris: 14:11:50 INFO - Chipset Model: Intel Iris 14:11:50 INFO - Type: GPU 14:11:50 INFO - Bus: Built-In 14:11:50 INFO - VRAM (Dynamic, Max): 1536 MB 14:11:50 INFO - Vendor: Intel (0x8086) 14:11:50 INFO - Device ID: 0x0a2e 14:11:50 INFO - Revision ID: 0x0009 14:11:50 INFO - Displays: 14:11:50 INFO - Display: 14:11:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:11:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:11:50 INFO - Display Serial Number: 1600x1200 60 14:11:50 INFO - Main Display: Yes 14:11:50 INFO - Mirror: Off 14:11:50 INFO - Online: Yes 14:11:50 INFO - Rotation: Supported 14:11:50 INFO - Return code: 0 14:11:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:11:50 INFO - Python 2.7.3 14:11:50 INFO - Return code: 0 14:11:50 INFO - grabbing minidump binary from tooltool 14:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:50 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 0x107e0ee00>, '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 0x107c37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e09b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:11:50 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 14:11:50 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 14:11:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:11:51 INFO - Return code: 0 14:11:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:11:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:11:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:11:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:11:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:11:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:11:52 INFO - Return code: 0 14:11:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0108', '--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 14:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0108 --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 14:11:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kBG0atjFJJ/Render', 14:11:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:52 INFO - 'HOME': '/Users/cltbld', 14:11:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:52 INFO - 'LOGNAME': 'cltbld', 14:11:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:11:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:52 INFO - 'MOZ_NO_REMOTE': '1', 14:11:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:11:52 INFO - 'NO_EM_RESTART': '1', 14:11:52 INFO - 'PAGER': '/bin/cat', 14:11:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:52 INFO - 'PWD': '/builds/slave/test', 14:11:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:11:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:52 INFO - 'SHELL': '/bin/bash', 14:11:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N8X1sbZ8Xa/Listeners', 14:11:52 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 14:11:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:52 INFO - 'USER': 'cltbld', 14:11:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:52 INFO - 'XPC_FLAGS': '0x0', 14:11:52 INFO - 'XPC_SERVICE_NAME': '0', 14:11:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0108', '--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 14:11:52 INFO - mozversion application_buildid: 20160324121213 14:11:52 INFO - mozversion application_changeset: aadf5e15faf8ba88b48d16bb396f115816b8f673 14:11:52 INFO - mozversion application_display_name: Nightly 14:11:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:11:52 INFO - mozversion application_name: Firefox 14:11:52 INFO - mozversion application_remotingname: firefox 14:11:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:11:52 INFO - mozversion application_vendor: Mozilla 14:11:52 INFO - mozversion application_version: 48.0a1 14:11:52 INFO - mozversion platform_buildid: 20160324121213 14:11:52 INFO - mozversion platform_changeset: aadf5e15faf8ba88b48d16bb396f115816b8f673 14:11:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:11:52 INFO - mozversion platform_version: 48.0a1 14:11:52 INFO - using testdate: 1458853912 14:11:52 INFO - actual date: 1458853912 14:11:52 INFO - starting webserver on 'localhost:57735' 14:11:52 INFO - SUITE-START | Running 2 tests 14:11:52 INFO - TEST-START | dromaeo_css 14:11:52 INFO - operating with platform_type : mac_ 14:11:52 INFO - Initialising browser for dromaeo_css test... 14:11:52 INFO - TEST-INFO | started process 2312 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/tmpy6kYbr/profile http://localhost:57735/getInfo.html) 14:11:54 INFO - PROCESS | 2312 | __metrics Screen width/height:1600/1200 14:11:54 INFO - PROCESS | 2312 | colorDepth:24 14:11:54 INFO - PROCESS | 2312 | Browser inner width/height: 1024/689 14:11:54 INFO - PROCESS | 2312 | __metrics 14:11:54 INFO - PROCESS | 2312 | 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" 14:11:54 ERROR - PROCESS | 2312 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:11:55 INFO - TEST-INFO | 2312: exit 0 14:11:55 INFO - Browser initialized. 14:11:55 INFO - Running cycle 1/1 for dromaeo_css test... 14:11:55 INFO - TEST-INFO | started process 2315 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/tmpy6kYbr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:12:07 INFO - PROCESS | 2315 | RSS: Main: 243859456 14:12:07 INFO - PROCESS | 2315 | 14:12:59 INFO - PROCESS | 2315 | 1458853979321 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] 14:15:08 INFO - PROCESS | 2315 | Cycle 1(1): loaded http://localhost:57735/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57735/tests/dromaeo/cssquery-ext.html) 14:15:10 INFO - PROCESS | 2315 | RSS: Main: 384499712 14:15:10 INFO - PROCESS | 2315 | 14:18:12 INFO - PROCESS | 2315 | Cycle 1(1): loaded http://localhost:57735/tests/dromaeo/cssquery-ext.html (next: http://localhost:57735/tests/dromaeo/cssquery-jquery.html) 14:18:13 INFO - PROCESS | 2315 | RSS: Main: 375824384 14:18:13 INFO - PROCESS | 2315 | 14:21:15 INFO - PROCESS | 2315 | Cycle 1(1): loaded http://localhost:57735/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57735/tests/dromaeo/cssquery-mootools.html) 14:21:15 INFO - PROCESS | 2315 | RSS: Main: 373145600 14:21:15 INFO - PROCESS | 2315 | 14:24:17 INFO - PROCESS | 2315 | Cycle 1(1): loaded http://localhost:57735/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57735/tests/dromaeo/cssquery-prototype.html) 14:24:18 INFO - PROCESS | 2315 | RSS: Main: 331030528 14:24:18 INFO - PROCESS | 2315 | 14:27:21 INFO - PROCESS | 2315 | Cycle 1(1): loaded http://localhost:57735/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57735/tests/dromaeo/cssquery-yui.html) 14:27:21 INFO - PROCESS | 2315 | RSS: Main: 333361152 14:27:21 INFO - PROCESS | 2315 | 14:30:24 INFO - PROCESS | 2315 | Cycle 1(1): loaded http://localhost:57735/tests/dromaeo/cssquery-yui.html (next: http://localhost:57735/tests/dromaeo/cssquery-dojo.html) 14:30:24 INFO - PROCESS | 2315 | RSS: Main: 381779968 14:30:24 INFO - PROCESS | 2315 | 14:30:24 INFO - PROCESS | 2315 | __start_tp_report 14:30:24 INFO - PROCESS | 2315 | _x_x_mozilla_page_load 14:30:24 INFO - PROCESS | 2315 | _x_x_mozilla_page_load_details 14:30:24 INFO - PROCESS | 2315 | |i|pagename|runs| 14:30:24 INFO - PROCESS | 2315 | |0;dojo.html;2834.773218142548;3417.6411476794938;3445.224824414507;3465.289615628796;3509.4209455439836;5585.832425027245;5601.915971260434;5614.29821272341;5647.915281270779;5662.122371032487;5647.3505546862125;5648.181013753004;5762.135679648044;5812.854678633025;5818.679972601505;5101.923471147936;5105.821296254632;5116.002379535992;5135.666181698196;5215.973920130413;5217.921731174036;5247.711375874325;5269.209618557228;5269.525742683158;5333.306670132897;4286.271333873234;5005.524475174852;5100.387953445573;5105.412877519096;5130.666506677054;5128.384593848725;5212.400573934008;5230.712310822903;5237.764300606482;5239.869003274911;5153.433122356538;5184.533391994701;5186.170212765939;5199.6360254782185;5239.685618862843;5583.664980101207;5616.550675945955;5638.859028524279;5656.971715141398;5689.431056894319;6076.301225359096;6098.765064574852;6195.504359651217;6214.347493513161;6230.221222347207;4519.84180553679;6226.719797609118;6257.092721555349;6259.530535209878;6268.122462855204;5754.136879468113;5785;5797.275340582427;5798;5848.590598658138;6156.415140561639;6157.9384206157365;6249.843753906189;6262.185915830913;6270;6064.272287325549;6091.725872335755;6097.3292937776805;6103.542234332443;6129.203203583595;6130.570860039844;6219.346968568326;6220.813375598739;6227.314995350508;6246.46905013079;6099.756009759649;6101.095933926299;6147.616786223064;6163.3528479509905;6163.96918015407;6184.690765461709;6188.319284878659;6198.566100372931;6201.627902325875;6203.844903877439;4701.2242979908615;4820.276958456259;4891.55975962158;4898.338724272249;4928.7289199093675;4377.759223242689;4426.513083560806;4429.092036132585;4446.844360447433;4451.799669014902;5622.775088996476;5672.971635141798;5687.971560142256;5690.5447564194765;5698.1452782083015;6172.845678857974;6247.468965137923;6248.5313601480075;6257.124002639634;6271.498280137669;5647.519960803295;5705.400932902068;5706.773043795521;5745.569082318842;5775.740091695884;5242.292290540804;5270.525652691276;5322.201669749491;5344.412114667383;5354.384245811703;6340.4293613575;6380.87238255223;6384.138141350858;6385.904211436832;6398.840028999312;6210.441060304594;6226.40849119333;6232.470240029648;6268.153799237045;6335.619862808247;6218.53360997936;6223.066540019034;6300.401461861115;6317.020861766434;6320.336364681642;4661.580457758818;5991.88016239664;5997;6003.5797494174985;6031.035034394476;5939.821805345847;6112.419320164578;6121.173641558511;6126.693665316628;6130.111133885651;5056.949430505648;5916.467517923407;5959.1657167995645;6041.75832966694;6072.787452439144;6052.818415447544;6060.484858787053;6076.33160352352;6109.053096770008;6109.511239100772;5361.758720857492;5844.649321040752;5924.911126333194;5941.989861723431;5950.494207992196;4961.677490963076;5947.137665038632;6068.9089663654195;6069.939300606938;6110.210535737379;5816.76732930678;5838.182654428469;5876.441738035051;5912.349641539513;5943.049112142036 14:30:24 INFO - PROCESS | 2315 | |1;ext.html;470.23351936343755;571.7570032736086;582.4845012164236;640.094266612743;641.8363317354075;39609.60390396095;40115.39826902595;40217.39673904886;40271.59728402715;40287.19425611486;42329.788351058276;42957.92605184872;42960.71117866461;42988.57011429885;43083.78458107705;9582.52087395631;9781.217502599811;9799.16707079899;9816.656417025406;9817.361871478366;9584.993575674558;9682.564284607175;9683.709488715349;9749.220062395027;9751.41491510508;9780.266480013992;9793.26550508711;9796.363236389612;9873.259505537113;9892.554835032404;9800.264980126483;9812.95093524535;9854.605815767361;9875;9888.258380621483;9677;9775.462349570771;9829.066238707312;9838.163756080741;9840.212782977345;41384.58615413868;41849.790751046356;41874.58125418768;41887.162256755;41893.58106418958;3261.184703824044;3262.6084869815772;3275.901722948315;3316.519104729825;3425.927313975059;29436.705632943824;29506.409871802658;30097.548536771967;30515.93194238191;30575.694243057507;2754.862256887168;2780.4717103750427;2822.082823082486;2832.773378129765;2842.0763251942994;457759;459945;461299;461670;462129.68935155444;45432;46284.30573541332;46344.7682761584;63154.36845631485;64199.35800642027;46317;46344.304835427494;46500.302495462594;46531.30203046957;46547;15941.282642281125;16077.437289694804;16100.75848862268;16112.194390280674;16118;12874;12910.22538647684;12917.418716157796;12932.741345173232;12936.09447338696;14988.925055374653;15042.623934401727;15045.623859403602;15085;15109.47116850927;6302.464290535356;6418;6476.222853257639;6479.416852483299;6488.740450382026;781.3085419403754;951.4861974533675;981.1562056631292;999.2505620784411;1045.4981608827804;28148.577771333035;29608.963686270876;29797.10608681743;30009.549856752164;30283.69716302853;1035.8549803027581;1095.3537412926253;1100.7138144082437;1112.8942750438696;1222.8593711723265;14960.251987400587;14993.100413975197;15039.47361842352;15230.405261304435;15429.614259643375;533244.3337783286;534932;538758;538902;539954;61058;61253.46866328378;61648;61886;61958.38041619616;1239.423667994387;1353.64128505946;1362.1826903857607;1488.0922637191304;1511.8488151184793;29885.850570747007;30745.750538663793;31300.06099817009;31578.36843263168;31642.841785790923;49626.75186624044;54538;56525;56806;57082.71458642846;438090;441005.7949710231;441380;441734;442592;27961.860190698917;33958.83020584881;34320.65679343174;35012.64987350094;35037.82481087578;46080.53919460763;46822;46853.06293874035;47198;48172.03655926932;38172.618273818014;38363.23273534569;38409;38479.807600961816;38870.80564597159;37403;37629.81185094057;37865;38304.616953830104;38775.98972159207;36967.44548831716;37287.067823304635;37971;38128;38252.80873595614;29521.409571808872;33192.66807331896;33264.501032485015;33479.66520334863;33498.832505837316;24454.87772561126;24700.50598987974;25042.123525676514;25136.465457724065;25385.365365866 14:30:24 INFO - PROCESS | 2315 | |2;jquery.html;350.5740525261807;361.33153665718424;367.3351234265978;369.6266770561732;373.14177391998396;19184.424467265988;19660.803391966077;20659.173633054677;21053.684194737092;21121.57756844862;19565.847756746745;19959.8024118553;20682.27612033579;20705.689414658755;20757.065932033056;5507.03626865299;5663.3204015518195;5730.169125476803;5736.713164341766;5740.397258287882;4090.0797320602774;4391.67062470316;5736.996025695486;6300.59046161998;6312.053192021188;5072.949270507284;6260.467860231885;6300.8739825203465;6301.558890877641;6301.747930082791;6083.665398403086;6213.316535181127;6277.2467303923595;6280.654563998978;6288.371162883721;5425.37608175061;5439.265699130607;5449.918251226235;5451.972740136313;5457.672539647634;24560;24961.750382496306;25053.24840254777;25212.495750084894;25330.873345633154;2069.8344132469365;2086.613976414368;2130.158587358;2213.623683973712;2239.507308392151;14078;14268.571942841627;14517;14547.272636368245;14899.180545070018;1683.621185233325;1757.2619499809982;1763.9118044097743;1789.5705030792647;1852.1387554787088;96550;99952.50023749907;100538.99999999927;100730.99999999927;102247.48876255646;8582.27050700685;9974.351667141758;10090.949545252226;10292;10390.792184156275;12855.485780568673;12985;13001.414936327888;13008.349582520836;13021;8345.66617335312;8412.032616249087;8422.115677853859;8475.703350382708;8496.40525163245;8686.087960764029;8694.434861733967;8740.475571465733;8748.91251087481;8851.247643950208;5964.538688021463;6070.757169713162;6077.513798896078;6092.664903430354;6107;1790.2928343304322;1814.9183286752127;1821.3261093395263;1828.7988321284647;1831.1210618902735;773.2692605487872;931.3061768982152;954.556131398889;995.0248756218801;1023.7031260934394;19734.40796776099;19858.20567177297;20639.8968005159;20862.885929472854;20906.686399704016;926.402470406584;963.8867108489706;1001.9949900250452;1003.0671475527683;1012.8278192707257;11077.833832492519;11302.095832333394;11319.094472442184;11342.829857552144;11391.886081139248;585292;608169;618789;644568;644951;77357.6132119347;98848;98923.51614725785;100504;101467.4926625377;1003.392947266893;1043.9895601044045;1045.4929359260752;1088.5972190289644;1112.7607564373536;17389.217485212943;17543.210555524776;18404.591985816103;18544.443666690022;18623.902741396872;51810.74094629654;52649.14393057452;53263.20105198347;53513;55140.44859551514;63605.727885441105;66632;68908.6554567244;72634;75598;7420.888686669597;7750.147483776667;7890.9605451972375;7911.643976020978;7936.56348900816;7982.880256796268;9232.538373081454;10130.8480372793;10870.945645271722;11978;10566.894331056592;10653.680389588324;10912.836307455553;10955.83566246491;11044.392558409365;10621.985224795804;10646.680599582025;10655.147588193082;10754.784904302027;10909.454527273763;10797.514111864828;11098;11133.944330278297;11305.095592352427;11324.207305488537;7575.848483030199;7776.339011183886;7821.178776228414;7822.100458447351;8056.516609003478;10140.391576505433;10725.249232553646;10935.507902144582;10936.289141205796;10960.56157753681 14:30:24 INFO - PROCESS | 2315 | |3;mootools.html;1438.9064710793805;1575.8424157584238;1597.712411765882;1869.9532511687205;1999.8000199979995;6601;8456.577171141442;8637.65449382024;8649.091845356234;8711.95644021779;8353.874691879626;8599.441036332633;8602.483850968947;8616.698415555456;8623.611937462814;2140.1439424230275;2350.4476448034698;2406.95186096278;2434.0020591557463;2463.088657196831;2463.0147940823636;2466.5436894174545;2470.258922323305;2471.0609968212143;2476.1333533263396;2333.8482998605036;2353.2822489140804;2392.629142482909;2394.820388470863;2396.137390539413;2409.963850542243;2448.0574978633267;2453.03105273416;2454.275988583372;2457.447074408262;2386.940326491834;2427.3446169534304;2452.1172377943926;2458.029078513995;2459.594166962449;7194.892076618855;8659.220670139655;8669.869951950663;8673.479591224484;8679.001914779818;5328.094223981932;5422.75597598109;5470.589705772043;5477.616566840323;5486.149646804752;3498.860045598173;3572.624874388204;3631.654992775682;3635.527381440396;3637.7999210043436;1021.7190272675;1031.0874875734953;1035.461559988809;1042.5881776698238;1049.2917280835482;11548.884511154865;11574.421278936019;11579.768404631945;11583.131265155147;11609.316649085835;4753.762311884392;4771.260454629538;4790.94599188178;4859.489753575895;4864.951350486521;9932.702018939442;9948.651797187063;9950.651727189514;9955.054269844353;9969.302148849656;5413.621046526705;5417.756200970965;5422.213779002022;5436.755346009439;5442.619016668875;4382.649388048949;4549.840755573539;4760.738159401266;4874.488178741252;4882.829100981448;3768.698504119664;3831.272058308912;3853.6917046636204;3857.517810273716;3888.7083468739957;1283.550757234979;1293.9870601294056;1294.1458637299338;1304.0610760252603;1308.7644224039764;1356.6947436826833;1371.4994027180207;1398.5944076217986;1400.9299535023208;1404.4592831759846;8033.678652853937;8202.630881610341;8218.342532597379;8222.424430289822;8267.545285009262;502.81898516534017;517.9015986962465;520.7630528109701;524.7245196271912;527.1907621800594;6222.751089956441;6223.128761973237;6265.749370025239;6272.1219029335925;6284.654344011124;10353.06822385989;10616.203784716177;10616.575336986434;10758.73103172427;10763.461826908624;10375;10518.947405262925;10562.894371056345;10617.787644247072;10626.840597391045;8240.50556966584;8271.751847444586;8361.456505327134;8363.916360836436;8377.120402357787;7407.62961851916;7785;7885.763427097197;7897.24976127267;7931.405144614062;9394;9451.054894510495;9478.810423791623;9567.091126342986;9652.083052110038;9724.513774311115;9799.755006124904;9884.11043006133;9920.156786673213;9943;6703.396694297537;6960.443164546723;7304.306090921354;7461.962690186731;7546.056742907137;8154;8215.876761848458;8221;8228.794280143044;8241.423100382915;7141.892871606826;7228.421726261781;7239.710411583477;7344.228855970046;7396.3343299103335;7037.26108758573;7095.680694368662;7195.532290401107;7201.171865235565;7238.6380680966795;7012.1935977363255;7540.0951885771865;7707.421943354383;7781.533108013311;7788.299053085249;6946.895796563157;7076.32774886385;7076.823079422849;7091.078159839188;7103.502754807114;6976.7558135465015;7123.928760712534;7143.571385716874;7150.570965742072;7156.928430715626 14:30:24 INFO - PROCESS | 2315 | |4;prototype.html;318.60492988694017;324.14264271003185;327.5888759606693;330.41186687695904;331.4431754652185;5401.351837779472;6324.177856878611;6409.262934762503;6486.643234622094;6601.438877695396;6302.747890084391;6389.840253993652;6393.936060639392;6399.6160230386095;6406.167198264219;4423.51341352451;4558.361829343878;4670.019295947855;4726.787294571753;4792.688475249115;4208.431861698662;4672.275797251432;4770.189067858472;4803.807847686088;4819.44576373718;4700.882477938062;4701.318308845215;4716.151092803294;4724.551167639069;4732.029933863567;3838.539375274957;3887.591802860687;4711.363965864616;4742.976285118552;4757.35775670287;3931.7051221158526;3995.200959808021;4048.9595104048876;4063.1467391847746;4076.082881351702;6208.50331973441;6320.178376811031;6326.588771729869;6328.778492752777;6332.525060620472;4846.975765121187;5582.581306402036;5592.496675299242;5601.523870471015;5618.353889302701;6481.93518064818;6779.966100169468;6892.345227203407;6901.1718593769065;6918.688659010357;3758.7932663703486;4566.54334566544;4570.177368073745;4580.8167673293365;4585.426821647294;6972.302769723038;7189.676464559107;7235.565866048001;7321.121465424183;7346.045014148127;4480.059187570581;4525.705829121097;4544.613707834805;4549.567791059844;4553.157665831832;4631.328457373662;4631.421072365954;4633.8841528961375;4634.189016922092;4635.420572428447;5485.725713714299;5487.533559647474;5495.313085864267;5499.312585926759;5513.2005859150195;6708.463322934153;6966.268541803139;6970.686319115652;6974.337437943387;6994.125734283215;1571.7485202367566;1602.4151184817458;1608.8712902967734;1611.6937781821416;1612.8870979031356;997.3118548201718;1006.3408467453829;1027.034587487774;1027.085893554737;1028.4189432970347;6314.242290925118;6465.062565928009;6471.870562588721;6494.253160886464;6500.9349906501275;7126.251743566954;7295.963520182365;7297;7306.561606303639;7322.743703970335;6591.077249185118;6609.107770450928;6612.933870661328;6619.801405957829;6622.768203112868;3083.799553029046;3775.8867233983024;3816.694664426839;3821.235752849386;3837.136644255076;6328.6519241442165;7176.744069787871;7614.048243969504;7623.504472209289;7633.389328853678;7413.258674132544;7473.551586904694;7488.700451981968;7490.2135275796345;7501.137369202612;7587.506812057309;7607.239276072349;7614.124375696755;7615.200403957616;7616.0099187105325;6389.616623002635;7226.4218862491925;7231.746888858865;7235.421166306788;7245.7826265212125;5193.870153246199;5519.834404967857;7066.152061752417;7071.292870712888;7175.067241258603;7560.243975602396;7587.734429294948;7631.3131818136635;7636.12184598756;7638.50349727266;4550.13547425988;4560.338750881037;4576.977115114403;4577.3591697161755;4587.17430862448;7252.5648461092505;7257.52826066304;7264.891026634499;7276.527025743309;7301.488895777245;6770.32296770319;6801.421879140131;7036.401905838061;7037.507374483942;7051.929480705127;5973.313068997121;6933.757318493828;7037.120359955005;7057.153141623038;7070.611116388648;6872.381485666314;6878.965605171942;6901.1718593769065;6901.654917254017;6903.413209877217;5750.706091129462;6986.860262794818;7054;7075.82310442243;7079.893801592877;6626.337366263335;6812.420944219797;6832;6897.896531552131;6924.93075069263 14:30:24 INFO - PROCESS | 2315 | |5;yui.html;688.2119972631338;701.8806802843518;733.3509843788249;735.955842649441;758.9544627322365;15172.620684482894;15175.54473365798;15369.308381122863;15369.769453458208;15386.461473848418;14165.504207352744;14262.072965257252;14267.429302827875;14272;14356.569302920929;714.91063617048;729.657061181244;880.3485420788602;899.5097671768901;901.8061116859874;792.5759718550577;886.1979908183105;903.70629545398;904.0959040959041;904.1230006893303;946.5361972633394;947.0671388682142;947.9052094790535;950.0831697411996;950.4867371619317;751.7519218657857;768.4735955870219;768.723259626534;926.2404828041009;937.0769791755116;609.7500024989778;672.1799404726227;698.6157613312657;699.9685014174374;700.6566782276648;12821.423035963404;14670.633234169125;15074.944753867234;15124.54626361211;15125.773113403307;12555.560555380609;12750.617481475478;12864.485420583165;13045.282509461977;13353.599392018255;9917.256205784595;10109.090181883666;10201.336913100624;10371.377717336909;10867.673969780919;3428.8114153721535;3484.1638006878165;3517.314123745871;3560.1455650643916;3760.868369607078;83981.58009209976;84041;85692.57153714253;86074.27851442999;86472.56763716204;9478.857817132748;9658.855117173249;9719.514024298756;9927.950360248153;10019.04438190721;22743.88628056849;22760.089596415957;22785.88607056954;22805.31584052448;22822.885885570468;7452.962735186397;7508.211637778064;7562.357199638092;7568.886466703004;7743.806404839811;4022.0749227677798;4076.3681629347498;4098.262312783728;4184.895377615584;4215.430916826251;3533.876314328986;3598.7121030318035;3598.8200589970397;3602.9099272518397;3610.422332426799;625.9812205633838;630.1870586942792;634.6890023888354;638.8594509207967;659.307726886767;534.2040359863774;584.2521572387351;603.4177019176516;612.6048698589385;638.6072565372262;7573.772786816405;7916.1688022757935;8190.631421586043;8243.25810677042;8248.711295104642;580.7705956147298;594.1296001358031;600.7266693654377;601.9307779605314;605.8424809549549;3688.465172550019;3797.9620203798163;3817.9427308590393;3838.808059597065;3935.4883865097354;84867.15132848592;87063.69404458939;87251;88276.67584986231;88433.67349489762;81599;82010;83275.58362208272;83415.16584834196;84041.57979210065;71489.64255178795;71565.6421717888;72654;73076.90384644235;73154;7563.281488258606;7598.734044308644;7855;7873.37013038944;7961.880571791312;48537.757311213216;49168.958507712654;49370.75314623404;49975;50076.992300769634;68854.31145688679;70710.29289707243;70715;71007.64496177486;72044.9193262091;10212.343718991982;10254.743631408975;10352.792944140925;10636.30863993838;10783.19126065564;10777.46112694378;10930.45347732626;11028.558857645925;11147.275427097213;11419.657410277705;10185.694429167137;10278.074973252444;10418.791624167627;10474.947625261824;10668.573257069631;10119.7470063249;10230.897691023292;10306.33008854422;10520.421376824348;10633.936606339304;10088.69733907984;10150.543225555015;10280.331778434378;10444.895551044392;10532.631357902437;8607.18231767981;8683.305335573014;8757.168069033432;8765.649374025223;9008.684696035607;8788.42875213109;8795.956020219857;8868.600912959062;8955.910440895508;9040.547972601213 14:30:24 INFO - PROCESS | 2315 | __end_tp_report 14:30:24 INFO - PROCESS | 2315 | __start_cc_report 14:30:24 INFO - PROCESS | 2315 | _x_x_mozilla_cycle_collect,1343 14:30:24 INFO - PROCESS | 2315 | __end_cc_report 14:30:24 INFO - PROCESS | 2315 | __startTimestamp1458855024775__endTimestamp 14:30:24 INFO - PROCESS | 2315 | 14:30:24 INFO - PROCESS | 2315 | ------- Summary: start ------- 14:30:24 INFO - PROCESS | 2315 | Number of tests: 6 14:30:24 INFO - PROCESS | 2315 | 14:30:24 INFO - PROCESS | 2315 | [#0] dojo.html Cycles:165 Average:5670.67 Median:5848.59 stddev:658.09 (11.3%) stddev-sans-first:621.37 14:30:24 INFO - PROCESS | 2315 | Values: 2834.8 3417.6 3445.2 3465.3 3509.4 5585.8 5601.9 5614.3 5647.9 5662.1 5647.4 5648.2 5762.1 5812.9 5818.7 5101.9 5105.8 5116.0 5135.7 5216.0 5217.9 5247.7 5269.2 5269.5 5333.3 4286.3 5005.5 5100.4 5105.4 5130.7 5128.4 5212.4 5230.7 5237.8 5239.9 5153.4 5184.5 5186.2 5199.6 5239.7 5583.7 5616.6 5638.9 5657.0 5689.4 6076.3 6098.8 6195.5 6214.3 6230.2 4519.8 6226.7 6257.1 6259.5 6268.1 5754.1 5785.0 5797.3 5798.0 5848.6 6156.4 6157.9 6249.8 6262.2 6270.0 6064.3 6091.7 6097.3 6103.5 6129.2 6130.6 6219.3 6220.8 6227.3 6246.5 6099.8 6101.1 6147.6 6163.4 6164.0 6184.7 6188.3 6198.6 6201.6 6203.8 4701.2 4820.3 4891.6 4898.3 4928.7 4377.8 4426.5 4429.1 4446.8 4451.8 5622.8 5673.0 5688.0 5690.5 5698.1 6172.8 6247.5 6248.5 6257.1 6271.5 5647.5 5705.4 5706.8 5745.6 5775.7 5242.3 5270.5 5322.2 5344.4 5354.4 6340.4 6380.9 6384.1 6385.9 6398.8 6210.4 6226.4 6232.5 6268.2 6335.6 6218.5 6223.1 6300.4 6317.0 6320.3 4661.6 5991.9 5997.0 6003.6 6031.0 5939.8 6112.4 6121.2 6126.7 6130.1 5056.9 5916.5 5959.2 6041.8 6072.8 6052.8 6060.5 6076.3 6109.1 6109.5 5361.8 5844.6 5924.9 5942.0 5950.5 4961.7 5947.1 6068.9 6069.9 6110.2 5816.8 5838.2 5876.4 5912.3 5943.0 14:30:24 INFO - PROCESS | 2315 | 14:30:24 INFO - PROCESS | 2315 | [#1] ext.html Cycles:180 Average:62408.88 Median:40835.89 stddev:127882.83 (313.2%) stddev-sans-first:128157.02 14:30:24 INFO - PROCESS | 2315 | Values: 470.2 571.8 582.5 640.1 641.8 39609.6 40115.4 40217.4 40271.6 40287.2 42329.8 42957.9 42960.7 42988.6 43083.8 9582.5 9781.2 9799.2 9816.7 9817.4 9585.0 9682.6 9683.7 9749.2 9751.4 9780.3 9793.3 9796.4 9873.3 9892.6 9800.3 9813.0 9854.6 9875.0 9888.3 9677.0 9775.5 9829.1 9838.2 9840.2 41384.6 41849.8 41874.6 41887.2 41893.6 3261.2 3262.6 3275.9 3316.5 3425.9 29436.7 29506.4 30097.5 30515.9 30575.7 2754.9 2780.5 2822.1 2832.8 2842.1 457759.0 459945.0 461299.0 461670.0 462129.7 45432.0 46284.3 46344.8 63154.4 64199.4 46317.0 46344.3 46500.3 46531.3 46547.0 15941.3 16077.4 16100.8 16112.2 16118.0 12874.0 12910.2 12917.4 12932.7 12936.1 14988.9 15042.6 15045.6 15085.0 15109.5 6302.5 6418.0 6476.2 6479.4 6488.7 781.3 951.5 981.2 999.3 1045.5 28148.6 29609.0 29797.1 30009.5 30283.7 1035.9 1095.4 1100.7 1112.9 1222.9 14960.3 14993.1 15039.5 15230.4 15429.6 533244.3 534932.0 538758.0 538902.0 539954.0 61058.0 61253.5 61648.0 61886.0 61958.4 1239.4 1353.6 1362.2 1488.1 1511.8 29885.9 30745.8 31300.1 31578.4 31642.8 49626.8 54538.0 56525.0 56806.0 57082.7 438090.0 441005.8 441380.0 441734.0 442592.0 27961.9 33958.8 34320.7 35012.6 35037.8 46080.5 46822.0 46853.1 47198.0 48172.0 38172.6 38363.2 38409.0 38479.8 38870.8 37403.0 37629.8 37865.0 38304.6 38776.0 36967.4 37287.1 37971.0 38128.0 38252.8 29521.4 33192.7 33264.5 33479.7 33498.8 24454.9 24700.5 25042.1 25136.5 25385.4 14:30:24 INFO - PROCESS | 2315 | 14:30:24 INFO - PROCESS | 2315 | [#2] jquery.html Cycles:180 Average:33928.76 Median:24760.88 stddev:102299.03 (413.1%) stddev-sans-first:102554.94 14:30:24 INFO - PROCESS | 2315 | Values: 350.6 361.3 367.3 369.6 373.1 19184.4 19660.8 20659.2 21053.7 21121.6 19565.8 19959.8 20682.3 20705.7 20757.1 5507.0 5663.3 5730.2 5736.7 5740.4 4090.1 4391.7 5737.0 6300.6 6312.1 5072.9 6260.5 6300.9 6301.6 6301.7 6083.7 6213.3 6277.2 6280.7 6288.4 5425.4 5439.3 5449.9 5452.0 5457.7 24560.0 24961.8 25053.2 25212.5 25330.9 2069.8 2086.6 2130.2 2213.6 2239.5 14078.0 14268.6 14517.0 14547.3 14899.2 1683.6 1757.3 1763.9 1789.6 1852.1 96550.0 99952.5 100539.0 100731.0 102247.5 8582.3 9974.4 10090.9 10292.0 10390.8 12855.5 12985.0 13001.4 13008.3 13021.0 8345.7 8412.0 8422.1 8475.7 8496.4 8686.1 8694.4 8740.5 8748.9 8851.2 5964.5 6070.8 6077.5 6092.7 6107.0 1790.3 1814.9 1821.3 1828.8 1831.1 773.3 931.3 954.6 995.0 1023.7 19734.4 19858.2 20639.9 20862.9 20906.7 926.4 963.9 1002.0 1003.1 1012.8 11077.8 11302.1 11319.1 11342.8 11391.9 585292.0 608169.0 618789.0 644568.0 644951.0 77357.6 98848.0 98923.5 100504.0 101467.5 1003.4 1044.0 1045.5 1088.6 1112.8 17389.2 17543.2 18404.6 18544.4 18623.9 51810.7 52649.1 53263.2 53513.0 55140.4 63605.7 66632.0 68908.7 72634.0 75598.0 7420.9 7750.1 7891.0 7911.6 7936.6 7982.9 9232.5 10130.8 10870.9 11978.0 10566.9 10653.7 10912.8 10955.8 11044.4 10622.0 10646.7 10655.1 10754.8 10909.5 10797.5 11098.0 11133.9 11305.1 11324.2 7575.8 7776.3 7821.2 7822.1 8056.5 10140.4 10725.2 10935.5 10936.3 10960.6 14:30:24 INFO - PROCESS | 2315 | 14:30:24 INFO - PROCESS | 2315 | [#3] mootools.html Cycles:180 Average:5975.83 Median:5439.69 stddev:3157.45 (58.0%) stddev-sans-first:3147.89 14:30:24 INFO - PROCESS | 2315 | Values: 1438.9 1575.8 1597.7 1870.0 1999.8 6601.0 8456.6 8637.7 8649.1 8712.0 8353.9 8599.4 8602.5 8616.7 8623.6 2140.1 2350.4 2407.0 2434.0 2463.1 2463.0 2466.5 2470.3 2471.1 2476.1 2333.8 2353.3 2392.6 2394.8 2396.1 2410.0 2448.1 2453.0 2454.3 2457.4 2386.9 2427.3 2452.1 2458.0 2459.6 7194.9 8659.2 8669.9 8673.5 8679.0 5328.1 5422.8 5470.6 5477.6 5486.1 3498.9 3572.6 3631.7 3635.5 3637.8 1021.7 1031.1 1035.5 1042.6 1049.3 11548.9 11574.4 11579.8 11583.1 11609.3 4753.8 4771.3 4790.9 4859.5 4865.0 9932.7 9948.7 9950.7 9955.1 9969.3 5413.6 5417.8 5422.2 5436.8 5442.6 4382.6 4549.8 4760.7 4874.5 4882.8 3768.7 3831.3 3853.7 3857.5 3888.7 1283.6 1294.0 1294.1 1304.1 1308.8 1356.7 1371.5 1398.6 1400.9 1404.5 8033.7 8202.6 8218.3 8222.4 8267.5 502.8 517.9 520.8 524.7 527.2 6222.8 6223.1 6265.7 6272.1 6284.7 10353.1 10616.2 10616.6 10758.7 10763.5 10375.0 10518.9 10562.9 10617.8 10626.8 8240.5 8271.8 8361.5 8363.9 8377.1 7407.6 7785.0 7885.8 7897.2 7931.4 9394.0 9451.1 9478.8 9567.1 9652.1 9724.5 9799.8 9884.1 9920.2 9943.0 6703.4 6960.4 7304.3 7462.0 7546.1 8154.0 8215.9 8221.0 8228.8 8241.4 7141.9 7228.4 7239.7 7344.2 7396.3 7037.3 7095.7 7195.5 7201.2 7238.6 7012.2 7540.1 7707.4 7781.5 7788.3 6946.9 7076.3 7076.8 7091.1 7103.5 6976.8 7123.9 7143.6 7150.6 7156.9 14:30:24 INFO - PROCESS | 2315 | 14:30:24 INFO - PROCESS | 2315 | [#4] prototype.html Cycles:180 Average:5646.33 Median:6396.78 stddev:1843.31 (28.8%) stddev-sans-first:1804.58 14:30:24 INFO - PROCESS | 2315 | Values: 318.6 324.1 327.6 330.4 331.4 5401.4 6324.2 6409.3 6486.6 6601.4 6302.7 6389.8 6393.9 6399.6 6406.2 4423.5 4558.4 4670.0 4726.8 4792.7 4208.4 4672.3 4770.2 4803.8 4819.4 4700.9 4701.3 4716.2 4724.6 4732.0 3838.5 3887.6 4711.4 4743.0 4757.4 3931.7 3995.2 4049.0 4063.1 4076.1 6208.5 6320.2 6326.6 6328.8 6332.5 4847.0 5582.6 5592.5 5601.5 5618.4 6481.9 6780.0 6892.3 6901.2 6918.7 3758.8 4566.5 4570.2 4580.8 4585.4 6972.3 7189.7 7235.6 7321.1 7346.0 4480.1 4525.7 4544.6 4549.6 4553.2 4631.3 4631.4 4633.9 4634.2 4635.4 5485.7 5487.5 5495.3 5499.3 5513.2 6708.5 6966.3 6970.7 6974.3 6994.1 1571.7 1602.4 1608.9 1611.7 1612.9 997.3 1006.3 1027.0 1027.1 1028.4 6314.2 6465.1 6471.9 6494.3 6500.9 7126.3 7296.0 7297.0 7306.6 7322.7 6591.1 6609.1 6612.9 6619.8 6622.8 3083.8 3775.9 3816.7 3821.2 3837.1 6328.7 7176.7 7614.0 7623.5 7633.4 7413.3 7473.6 7488.7 7490.2 7501.1 7587.5 7607.2 7614.1 7615.2 7616.0 6389.6 7226.4 7231.7 7235.4 7245.8 5193.9 5519.8 7066.2 7071.3 7175.1 7560.2 7587.7 7631.3 7636.1 7638.5 4550.1 4560.3 4577.0 4577.4 4587.2 7252.6 7257.5 7264.9 7276.5 7301.5 6770.3 6801.4 7036.4 7037.5 7051.9 5973.3 6933.8 7037.1 7057.2 7070.6 6872.4 6879.0 6901.2 6901.7 6903.4 5750.7 6986.9 7054.0 7075.8 7079.9 6626.3 6812.4 6832.0 6897.9 6924.9 14:30:24 INFO - PROCESS | 2315 | 14:30:24 INFO - PROCESS | 2315 | [#5] yui.html Cycles:180 Average:18417.82 Median:628.08 stddev:26265.17 (4181.8%) stddev-sans-first:26305.11 14:30:24 INFO - PROCESS | 2315 | Values: 688.2 701.9 733.4 736.0 759.0 15172.6 15175.5 15369.3 15369.8 15386.5 14165.5 14262.1 14267.4 14272.0 14356.6 714.9 729.7 880.3 899.5 901.8 792.6 886.2 903.7 904.1 904.1 946.5 947.1 947.9 950.1 950.5 751.8 768.5 768.7 926.2 937.1 609.8 672.2 698.6 700.0 700.7 12821.4 14670.6 15074.9 15124.5 15125.8 12555.6 12750.6 12864.5 13045.3 13353.6 9917.3 10109.1 10201.3 10371.4 10867.7 3428.8 3484.2 3517.3 3560.1 3760.9 83981.6 84041.0 85692.6 86074.3 86472.6 9478.9 9658.9 9719.5 9928.0 10019.0 22743.9 22760.1 22785.9 22805.3 22822.9 7453.0 7508.2 7562.4 7568.9 7743.8 4022.1 4076.4 4098.3 4184.9 4215.4 3533.9 3598.7 3598.8 3602.9 3610.4 626.0 630.2 634.7 638.9 659.3 534.2 584.3 603.4 612.6 638.6 7573.8 7916.2 8190.6 8243.3 8248.7 580.8 594.1 600.7 601.9 605.8 3688.5 3798.0 3817.9 3838.8 3935.5 84867.2 87063.7 87251.0 88276.7 88433.7 81599.0 82010.0 83275.6 83415.2 84041.6 71489.6 71565.6 72654.0 73076.9 73154.0 7563.3 7598.7 7855.0 7873.4 7961.9 48537.8 49169.0 49370.8 49975.0 50077.0 68854.3 70710.3 70715.0 71007.6 72044.9 10212.3 10254.7 10352.8 10636.3 10783.2 10777.5 10930.5 11028.6 11147.3 11419.7 10185.7 10278.1 10418.8 10474.9 10668.6 10119.7 10230.9 10306.3 10520.4 10633.9 10088.7 10150.5 10280.3 10444.9 10532.6 8607.2 8683.3 8757.2 8765.6 9008.7 8788.4 8796.0 8868.6 8955.9 9040.5 14:30:24 INFO - PROCESS | 2315 | -------- Summary: end -------- 14:30:24 INFO - PROCESS | 2315 | 14:30:25 INFO - TEST-INFO | 2315: exit 0 14:30:25 INFO - TEST-OK | dromaeo_css | took 1112936ms 14:30:25 INFO - TEST-START | kraken 14:30:25 INFO - operating with platform_type : mac_ 14:30:25 INFO - Initialising browser for kraken test... 14:30:25 INFO - TEST-INFO | started process 2319 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/tmp4avVP0/profile http://localhost:57735/getInfo.html) 14:30:27 INFO - PROCESS | 2319 | __metrics Screen width/height:1600/1200 14:30:27 INFO - PROCESS | 2319 | colorDepth:24 14:30:27 INFO - PROCESS | 2319 | Browser inner width/height: 1024/689 14:30:27 INFO - PROCESS | 2319 | __metrics 14:30:27 INFO - PROCESS | 2319 | 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" 14:30:27 ERROR - PROCESS | 2319 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:30:28 INFO - TEST-INFO | 2319: exit 0 14:30:28 INFO - Browser initialized. 14:30:28 INFO - Running cycle 1/1 for kraken test... 14:30:28 INFO - TEST-INFO | started process 2321 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/tmp4avVP0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:30:40 INFO - PROCESS | 2321 | RSS: Main: 244191232 14:30:40 INFO - PROCESS | 2321 | 14:30:42 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:57735/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57735/tests/kraken/driver.html?testName=audio-beat-detection) 14:30:43 INFO - PROCESS | 2321 | RSS: Main: 290033664 14:30:43 INFO - PROCESS | 2321 | 14:30:46 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:57735/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57735/tests/kraken/driver.html?testName=audio-dft) 14:30:46 INFO - PROCESS | 2321 | RSS: Main: 300380160 14:30:46 INFO - PROCESS | 2321 | 14:30:50 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:57735/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57735/tests/kraken/driver.html?testName=audio-fft) 14:30:50 INFO - PROCESS | 2321 | RSS: Main: 284749824 14:30:50 INFO - PROCESS | 2321 | 14:30:52 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:57735/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57735/tests/kraken/driver.html?testName=audio-oscillator) 14:30:53 INFO - PROCESS | 2321 | RSS: Main: 286322688 14:30:53 INFO - PROCESS | 2321 | 14:30:55 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:57735/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57735/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:30:55 INFO - PROCESS | 2321 | RSS: Main: 287387648 14:30:55 INFO - PROCESS | 2321 | 14:30:58 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:57735/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57735/tests/kraken/driver.html?testName=imaging-darkroom) 14:30:59 INFO - PROCESS | 2321 | RSS: Main: 288047104 14:30:59 INFO - PROCESS | 2321 | 14:31:02 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:57735/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57735/tests/kraken/driver.html?testName=imaging-desaturate) 14:31:02 INFO - PROCESS | 2321 | RSS: Main: 289456128 14:31:02 INFO - PROCESS | 2321 | 14:31:05 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:57735/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57735/tests/kraken/driver.html?testName=json-parse-financial) 14:31:05 INFO - PROCESS | 2321 | RSS: Main: 289423360 14:31:05 INFO - PROCESS | 2321 | 14:31:07 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:57735/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57735/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:31:08 INFO - PROCESS | 2321 | RSS: Main: 324808704 14:31:08 INFO - PROCESS | 2321 | 14:31:09 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:57735/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57735/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:31:10 INFO - PROCESS | 2321 | RSS: Main: 324960256 14:31:10 INFO - PROCESS | 2321 | 14:31:12 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:57735/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57735/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:31:13 INFO - PROCESS | 2321 | RSS: Main: 330891264 14:31:13 INFO - PROCESS | 2321 | 14:31:15 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:57735/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57735/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:31:16 INFO - PROCESS | 2321 | RSS: Main: 331907072 14:31:16 INFO - PROCESS | 2321 | 14:31:19 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:57735/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57735/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:31:19 INFO - PROCESS | 2321 | RSS: Main: 331612160 14:31:19 INFO - PROCESS | 2321 | 14:31:21 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:57735/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57735/tests/kraken/driver.html?testName=ai-astar) 14:31:21 INFO - PROCESS | 2321 | RSS: Main: 395055104 14:31:21 INFO - PROCESS | 2321 | 14:31:21 INFO - PROCESS | 2321 | __start_tp_report 14:31:21 INFO - PROCESS | 2321 | _x_x_mozilla_page_load 14:31:21 INFO - PROCESS | 2321 | _x_x_mozilla_page_load_details 14:31:21 INFO - PROCESS | 2321 | |i|pagename|runs| 14:31:21 INFO - PROCESS | 2321 | |0;ai-astar;112;108;112;111;112;112;117;112;111;112 14:31:21 INFO - PROCESS | 2321 | |1;audio-beat-detection;157;120;150;193;142;141;143;118;164;117 14:31:21 INFO - PROCESS | 2321 | |2;audio-dft;186;201;268;204;186;187;185;181;183;183 14:31:21 INFO - PROCESS | 2321 | |3;audio-fft;78;75;85;81;58;59;58;75;76;55 14:31:21 INFO - PROCESS | 2321 | |4;audio-oscillator;97;91;130;77;77;82;115;78;78;117 14:31:21 INFO - PROCESS | 2321 | |5;imaging-gaussian-blur;88;85;87;88;135;85;88;84;88;84 14:31:21 INFO - PROCESS | 2321 | |6;imaging-darkroom;93;93;94;94;93;92;93;93;92;92 14:31:21 INFO - PROCESS | 2321 | |7;imaging-desaturate;86;85;86;85;86;87;85;83;85;86 14:31:21 INFO - PROCESS | 2321 | |8;json-parse-financial;55;55;54;54;55;55;56;65;55;52 14:31:21 INFO - PROCESS | 2321 | |9;json-stringify-tinderbox;67;68;64;76;72;68;71;67;68;72 14:31:21 INFO - PROCESS | 2321 | |10;stanford-crypto-aes;83;83;83;83;82;84;84;83;83;84 14:31:21 INFO - PROCESS | 2321 | |11;stanford-crypto-ccm;121;128;137;139;139;109;123;134;130;140 14:31:21 INFO - PROCESS | 2321 | |12;stanford-crypto-pbkdf2;137;127;141;140;141;130;140;141;139;141 14:31:21 INFO - PROCESS | 2321 | |13;stanford-crypto-sha256-iterative;68;67;66;67;68;67;70;83;91;95 14:31:21 INFO - PROCESS | 2321 | __end_tp_report 14:31:21 INFO - PROCESS | 2321 | __start_cc_report 14:31:21 INFO - PROCESS | 2321 | _x_x_mozilla_cycle_collect,1274 14:31:21 INFO - PROCESS | 2321 | __end_cc_report 14:31:21 INFO - PROCESS | 2321 | __startTimestamp1458855081664__endTimestamp 14:31:21 INFO - PROCESS | 2321 | 14:31:21 INFO - PROCESS | 2321 | ------- Summary: start ------- 14:31:21 INFO - PROCESS | 2321 | Number of tests: 14 14:31:21 INFO - PROCESS | 2321 | 14:31:21 INFO - PROCESS | 2321 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:2.18 (1.9%) stddev-sans-first:2.32 14:31:21 INFO - PROCESS | 2321 | Values: 112.0 108.0 112.0 111.0 112.0 112.0 117.0 112.0 111.0 112.0 14:31:21 INFO - PROCESS | 2321 | 14:31:21 INFO - PROCESS | 2321 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:146.50 stddev:23.57 (16.1%) stddev-sans-first:24.56 14:31:21 INFO - PROCESS | 2321 | Values: 157.0 120.0 150.0 193.0 142.0 141.0 143.0 118.0 164.0 117.0 14:31:21 INFO - PROCESS | 2321 | 14:31:21 INFO - PROCESS | 2321 | [#2] audio-dft Cycles:10 Average:196.40 Median:186.50 stddev:26.32 (14.1%) stddev-sans-first:27.65 14:31:21 INFO - PROCESS | 2321 | Values: 186.0 201.0 268.0 204.0 186.0 187.0 185.0 181.0 183.0 183.0 14:31:21 INFO - PROCESS | 2321 | 14:31:21 INFO - PROCESS | 2321 | [#3] audio-fft Cycles:10 Average:70.00 Median:75.50 stddev:11.21 (14.8%) stddev-sans-first:11.50 14:31:21 INFO - PROCESS | 2321 | Values: 78.0 75.0 85.0 81.0 58.0 59.0 58.0 75.0 76.0 55.0 14:31:21 INFO - PROCESS | 2321 | 14:31:21 INFO - PROCESS | 2321 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:78.00 stddev:19.77 (25.3%) stddev-sans-first:20.94 14:31:21 INFO - PROCESS | 2321 | Values: 97.0 91.0 130.0 77.0 77.0 82.0 115.0 78.0 78.0 117.0 14:31:21 INFO - PROCESS | 2321 | 14:31:21 INFO - PROCESS | 2321 | [#5] imaging-gaussian-blur Cycles:10 Average:91.20 Median:87.50 stddev:15.48 (17.7%) stddev-sans-first:16.38 14:31:21 INFO - PROCESS | 2321 | Values: 88.0 85.0 87.0 88.0 135.0 85.0 88.0 84.0 88.0 84.0 14:31:21 INFO - PROCESS | 2321 | 14:31:21 INFO - PROCESS | 2321 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:93.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 14:31:21 INFO - PROCESS | 2321 | Values: 93.0 93.0 94.0 94.0 93.0 92.0 93.0 93.0 92.0 92.0 14:31:21 INFO - PROCESS | 2321 | 14:31:21 INFO - PROCESS | 2321 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:86.00 stddev:1.07 (1.2%) stddev-sans-first:1.12 14:31:21 INFO - PROCESS | 2321 | Values: 86.0 85.0 86.0 85.0 86.0 87.0 85.0 83.0 85.0 86.0 14:31:21 INFO - PROCESS | 2321 | 14:31:21 INFO - PROCESS | 2321 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:3.47 (6.3%) stddev-sans-first:3.67 14:31:21 INFO - PROCESS | 2321 | Values: 55.0 55.0 54.0 54.0 55.0 55.0 56.0 65.0 55.0 52.0 14:31:21 INFO - PROCESS | 2321 | 14:31:21 INFO - PROCESS | 2321 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.50 stddev:3.43 (4.9%) stddev-sans-first:3.54 14:31:21 INFO - PROCESS | 2321 | Values: 67.0 68.0 64.0 76.0 72.0 68.0 71.0 67.0 68.0 72.0 14:31:21 INFO - PROCESS | 2321 | 14:31:21 INFO - PROCESS | 2321 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:0.63 (0.8%) stddev-sans-first:0.67 14:31:21 INFO - PROCESS | 2321 | Values: 83.0 83.0 83.0 83.0 82.0 84.0 84.0 83.0 83.0 84.0 14:31:21 INFO - PROCESS | 2321 | 14:31:21 INFO - PROCESS | 2321 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:135.50 stddev:10.01 (7.4%) stddev-sans-first:10.07 14:31:21 INFO - PROCESS | 2321 | Values: 121.0 128.0 137.0 139.0 139.0 109.0 123.0 134.0 130.0 140.0 14:31:21 INFO - PROCESS | 2321 | 14:31:21 INFO - PROCESS | 2321 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.70 Median:140.50 stddev:5.06 (3.6%) stddev-sans-first:5.36 14:31:21 INFO - PROCESS | 2321 | Values: 137.0 127.0 141.0 140.0 141.0 130.0 140.0 141.0 139.0 141.0 14:31:21 INFO - PROCESS | 2321 | 14:31:21 INFO - PROCESS | 2321 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:69.00 stddev:11.10 (16.1%) stddev-sans-first:11.55 14:31:21 INFO - PROCESS | 2321 | Values: 68.0 67.0 66.0 67.0 68.0 67.0 70.0 83.0 91.0 95.0 14:31:21 INFO - PROCESS | 2321 | -------- Summary: end -------- 14:31:21 INFO - PROCESS | 2321 | 14:31:22 INFO - TEST-INFO | 2321: exit 0 14:31:22 INFO - TEST-OK | kraken | took 57073ms 14:31:22 INFO - SUITE-END | took 1170s 14:31:22 INFO - Completed test suite (00:19:30) 14:31:22 INFO - javascript benchmark 14:31:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2834.773218142548, 3417.6411476794938, 3445.224824414507, 3465.289615628796, 3509.4209455439836, 5585.832425027245, 5601.915971260434, 5614.29821272341, 5647.915281270779, 5662.122371032487, 5647.3505546862125, 5648.181013753004, 5762.135679648044, 5812.854678633025, 5818.679972601505, 5101.923471147936, 5105.821296254632, 5116.002379535992, 5135.666181698196, 5215.973920130413, 5217.921731174036, 5247.711375874325, 5269.209618557228, 5269.525742683158, 5333.306670132897, 4286.271333873234, 5005.524475174852, 5100.387953445573, 5105.412877519096, 5130.666506677054, 5128.384593848725, 5212.400573934008, 5230.712310822903, 5237.764300606482, 5239.869003274911, 5153.433122356538, 5184.533391994701, 5186.170212765939, 5199.6360254782185, 5239.685618862843, 5583.664980101207, 5616.550675945955, 5638.859028524279, 5656.971715141398, 5689.431056894319, 6076.301225359096, 6098.765064574852, 6195.504359651217, 6214.347493513161, 6230.221222347207, 4519.84180553679, 6226.719797609118, 6257.092721555349, 6259.530535209878, 6268.122462855204, 5754.136879468113, 5785.0, 5797.275340582427, 5798.0, 5848.590598658138, 6156.415140561639, 6157.9384206157365, 6249.843753906189, 6262.185915830913, 6270.0, 6064.272287325549, 6091.725872335755, 6097.3292937776805, 6103.542234332443, 6129.203203583595, 6130.570860039844, 6219.346968568326, 6220.813375598739, 6227.314995350508, 6246.46905013079, 6099.756009759649, 6101.095933926299, 6147.616786223064, 6163.3528479509905, 6163.96918015407, 6184.690765461709, 6188.319284878659, 6198.566100372931, 6201.627902325875, 6203.844903877439, 4701.2242979908615, 4820.276958456259, 4891.55975962158, 4898.338724272249, 4928.7289199093675, 4377.759223242689, 4426.513083560806, 4429.092036132585, 4446.844360447433, 4451.799669014902, 5622.775088996476, 5672.971635141798, 5687.971560142256, 5690.5447564194765, 5698.1452782083015, 6172.845678857974, 6247.468965137923, 6248.5313601480075, 6257.124002639634, 6271.498280137669, 5647.519960803295, 5705.400932902068, 5706.773043795521, 5745.569082318842, 5775.740091695884, 5242.292290540804, 5270.525652691276, 5322.201669749491, 5344.412114667383, 5354.384245811703, 6340.4293613575, 6380.87238255223, 6384.138141350858, 6385.904211436832, 6398.840028999312, 6210.441060304594, 6226.40849119333, 6232.470240029648, 6268.153799237045, 6335.619862808247, 6218.53360997936, 6223.066540019034, 6300.401461861115, 6317.020861766434, 6320.336364681642, 4661.580457758818, 5991.88016239664, 5997.0, 6003.5797494174985, 6031.035034394476, 5939.821805345847, 6112.419320164578, 6121.173641558511, 6126.693665316628, 6130.111133885651, 5056.949430505648, 5916.467517923407, 5959.1657167995645, 6041.75832966694, 6072.787452439144, 6052.818415447544, 6060.484858787053, 6076.33160352352, 6109.053096770008, 6109.511239100772, 5361.758720857492, 5844.649321040752, 5924.911126333194, 5941.989861723431, 5950.494207992196, 4961.677490963076, 5947.137665038632, 6068.9089663654195, 6069.939300606938, 6110.210535737379, 5816.76732930678, 5838.182654428469, 5876.441738035051, 5912.349641539513, 5943.049112142036], "unit": "score", "name": "dojo.html", "value": 5630.005080154631}, {"lowerIsBetter": false, "replicates": [470.23351936343755, 571.7570032736086, 582.4845012164236, 640.094266612743, 641.8363317354075, 39609.60390396095, 40115.39826902595, 40217.39673904886, 40271.59728402715, 40287.19425611486, 42329.788351058276, 42957.92605184872, 42960.71117866461, 42988.57011429885, 43083.78458107705, 9582.52087395631, 9781.217502599811, 9799.16707079899, 9816.656417025406, 9817.361871478366, 9584.993575674558, 9682.564284607175, 9683.709488715349, 9749.220062395027, 9751.41491510508, 9780.266480013992, 9793.26550508711, 9796.363236389612, 9873.259505537113, 9892.554835032404, 9800.264980126483, 9812.95093524535, 9854.605815767361, 9875.0, 9888.258380621483, 9677.0, 9775.462349570771, 9829.066238707312, 9838.163756080741, 9840.212782977345, 41384.58615413868, 41849.790751046356, 41874.58125418768, 41887.162256755, 41893.58106418958, 3261.184703824044, 3262.6084869815772, 3275.901722948315, 3316.519104729825, 3425.927313975059, 29436.705632943824, 29506.409871802658, 30097.548536771967, 30515.93194238191, 30575.694243057507, 2754.862256887168, 2780.4717103750427, 2822.082823082486, 2832.773378129765, 2842.0763251942994, 457759.0, 459945.0, 461299.0, 461670.0, 462129.68935155444, 45432.0, 46284.30573541332, 46344.7682761584, 63154.36845631485, 64199.35800642027, 46317.0, 46344.304835427494, 46500.302495462594, 46531.30203046957, 46547.0, 15941.282642281125, 16077.437289694804, 16100.75848862268, 16112.194390280674, 16118.0, 12874.0, 12910.22538647684, 12917.418716157796, 12932.741345173232, 12936.09447338696, 14988.925055374653, 15042.623934401727, 15045.623859403602, 15085.0, 15109.47116850927, 6302.464290535356, 6418.0, 6476.222853257639, 6479.416852483299, 6488.740450382026, 781.3085419403754, 951.4861974533675, 981.1562056631292, 999.2505620784411, 1045.4981608827804, 28148.577771333035, 29608.963686270876, 29797.10608681743, 30009.549856752164, 30283.69716302853, 1035.8549803027581, 1095.3537412926253, 1100.7138144082437, 1112.8942750438696, 1222.8593711723265, 14960.251987400587, 14993.100413975197, 15039.47361842352, 15230.405261304435, 15429.614259643375, 533244.3337783286, 534932.0, 538758.0, 538902.0, 539954.0, 61058.0, 61253.46866328378, 61648.0, 61886.0, 61958.38041619616, 1239.423667994387, 1353.64128505946, 1362.1826903857607, 1488.0922637191304, 1511.8488151184793, 29885.850570747007, 30745.750538663793, 31300.06099817009, 31578.36843263168, 31642.841785790923, 49626.75186624044, 54538.0, 56525.0, 56806.0, 57082.71458642846, 438090.0, 441005.7949710231, 441380.0, 441734.0, 442592.0, 27961.860190698917, 33958.83020584881, 34320.65679343174, 35012.64987350094, 35037.82481087578, 46080.53919460763, 46822.0, 46853.06293874035, 47198.0, 48172.03655926932, 38172.618273818014, 38363.23273534569, 38409.0, 38479.807600961816, 38870.80564597159, 37403.0, 37629.81185094057, 37865.0, 38304.616953830104, 38775.98972159207, 36967.44548831716, 37287.067823304635, 37971.0, 38128.0, 38252.80873595614, 29521.409571808872, 33192.66807331896, 33264.501032485015, 33479.66520334863, 33498.832505837316, 24454.87772561126, 24700.50598987974, 25042.123525676514, 25136.465457724065, 25385.365365866], "unit": "score", "name": "ext.html", "value": 19496.840313795394}, {"lowerIsBetter": false, "replicates": [350.5740525261807, 361.33153665718424, 367.3351234265978, 369.6266770561732, 373.14177391998396, 19184.424467265988, 19660.803391966077, 20659.173633054677, 21053.684194737092, 21121.57756844862, 19565.847756746745, 19959.8024118553, 20682.27612033579, 20705.689414658755, 20757.065932033056, 5507.03626865299, 5663.3204015518195, 5730.169125476803, 5736.713164341766, 5740.397258287882, 4090.0797320602774, 4391.67062470316, 5736.996025695486, 6300.59046161998, 6312.053192021188, 5072.949270507284, 6260.467860231885, 6300.8739825203465, 6301.558890877641, 6301.747930082791, 6083.665398403086, 6213.316535181127, 6277.2467303923595, 6280.654563998978, 6288.371162883721, 5425.37608175061, 5439.265699130607, 5449.918251226235, 5451.972740136313, 5457.672539647634, 24560.0, 24961.750382496306, 25053.24840254777, 25212.495750084894, 25330.873345633154, 2069.8344132469365, 2086.613976414368, 2130.158587358, 2213.623683973712, 2239.507308392151, 14078.0, 14268.571942841627, 14517.0, 14547.272636368245, 14899.180545070018, 1683.621185233325, 1757.2619499809982, 1763.9118044097743, 1789.5705030792647, 1852.1387554787088, 96550.0, 99952.50023749907, 100538.99999999927, 100730.99999999927, 102247.48876255646, 8582.27050700685, 9974.351667141758, 10090.949545252226, 10292.0, 10390.792184156275, 12855.485780568673, 12985.0, 13001.414936327888, 13008.349582520836, 13021.0, 8345.66617335312, 8412.032616249087, 8422.115677853859, 8475.703350382708, 8496.40525163245, 8686.087960764029, 8694.434861733967, 8740.475571465733, 8748.91251087481, 8851.247643950208, 5964.538688021463, 6070.757169713162, 6077.513798896078, 6092.664903430354, 6107.0, 1790.2928343304322, 1814.9183286752127, 1821.3261093395263, 1828.7988321284647, 1831.1210618902735, 773.2692605487872, 931.3061768982152, 954.556131398889, 995.0248756218801, 1023.7031260934394, 19734.40796776099, 19858.20567177297, 20639.8968005159, 20862.885929472854, 20906.686399704016, 926.402470406584, 963.8867108489706, 1001.9949900250452, 1003.0671475527683, 1012.8278192707257, 11077.833832492519, 11302.095832333394, 11319.094472442184, 11342.829857552144, 11391.886081139248, 585292.0, 608169.0, 618789.0, 644568.0, 644951.0, 77357.6132119347, 98848.0, 98923.51614725785, 100504.0, 101467.4926625377, 1003.392947266893, 1043.9895601044045, 1045.4929359260752, 1088.5972190289644, 1112.7607564373536, 17389.217485212943, 17543.210555524776, 18404.591985816103, 18544.443666690022, 18623.902741396872, 51810.74094629654, 52649.14393057452, 53263.20105198347, 53513.0, 55140.44859551514, 63605.727885441105, 66632.0, 68908.6554567244, 72634.0, 75598.0, 7420.888686669597, 7750.147483776667, 7890.9605451972375, 7911.643976020978, 7936.56348900816, 7982.880256796268, 9232.538373081454, 10130.8480372793, 10870.945645271722, 11978.0, 10566.894331056592, 10653.680389588324, 10912.836307455553, 10955.83566246491, 11044.392558409365, 10621.985224795804, 10646.680599582025, 10655.147588193082, 10754.784904302027, 10909.454527273763, 10797.514111864828, 11098.0, 11133.944330278297, 11305.095592352427, 11324.207305488537, 7575.848483030199, 7776.339011183886, 7821.178776228414, 7822.100458447351, 8056.516609003478, 10140.391576505433, 10725.249232553646, 10935.507902144582, 10936.289141205796, 10960.56157753681], "unit": "score", "name": "jquery.html", "value": 9385.03086188875}, {"lowerIsBetter": false, "replicates": [1438.9064710793805, 1575.8424157584238, 1597.712411765882, 1869.9532511687205, 1999.8000199979995, 6601.0, 8456.577171141442, 8637.65449382024, 8649.091845356234, 8711.95644021779, 8353.874691879626, 8599.441036332633, 8602.483850968947, 8616.698415555456, 8623.611937462814, 2140.1439424230275, 2350.4476448034698, 2406.95186096278, 2434.0020591557463, 2463.088657196831, 2463.0147940823636, 2466.5436894174545, 2470.258922323305, 2471.0609968212143, 2476.1333533263396, 2333.8482998605036, 2353.2822489140804, 2392.629142482909, 2394.820388470863, 2396.137390539413, 2409.963850542243, 2448.0574978633267, 2453.03105273416, 2454.275988583372, 2457.447074408262, 2386.940326491834, 2427.3446169534304, 2452.1172377943926, 2458.029078513995, 2459.594166962449, 7194.892076618855, 8659.220670139655, 8669.869951950663, 8673.479591224484, 8679.001914779818, 5328.094223981932, 5422.75597598109, 5470.589705772043, 5477.616566840323, 5486.149646804752, 3498.860045598173, 3572.624874388204, 3631.654992775682, 3635.527381440396, 3637.7999210043436, 1021.7190272675, 1031.0874875734953, 1035.461559988809, 1042.5881776698238, 1049.2917280835482, 11548.884511154865, 11574.421278936019, 11579.768404631945, 11583.131265155147, 11609.316649085835, 4753.762311884392, 4771.260454629538, 4790.94599188178, 4859.489753575895, 4864.951350486521, 9932.702018939442, 9948.651797187063, 9950.651727189514, 9955.054269844353, 9969.302148849656, 5413.621046526705, 5417.756200970965, 5422.213779002022, 5436.755346009439, 5442.619016668875, 4382.649388048949, 4549.840755573539, 4760.738159401266, 4874.488178741252, 4882.829100981448, 3768.698504119664, 3831.272058308912, 3853.6917046636204, 3857.517810273716, 3888.7083468739957, 1283.550757234979, 1293.9870601294056, 1294.1458637299338, 1304.0610760252603, 1308.7644224039764, 1356.6947436826833, 1371.4994027180207, 1398.5944076217986, 1400.9299535023208, 1404.4592831759846, 8033.678652853937, 8202.630881610341, 8218.342532597379, 8222.424430289822, 8267.545285009262, 502.81898516534017, 517.9015986962465, 520.7630528109701, 524.7245196271912, 527.1907621800594, 6222.751089956441, 6223.128761973237, 6265.749370025239, 6272.1219029335925, 6284.654344011124, 10353.06822385989, 10616.203784716177, 10616.575336986434, 10758.73103172427, 10763.461826908624, 10375.0, 10518.947405262925, 10562.894371056345, 10617.787644247072, 10626.840597391045, 8240.50556966584, 8271.751847444586, 8361.456505327134, 8363.916360836436, 8377.120402357787, 7407.62961851916, 7785.0, 7885.763427097197, 7897.24976127267, 7931.405144614062, 9394.0, 9451.054894510495, 9478.810423791623, 9567.091126342986, 9652.083052110038, 9724.513774311115, 9799.755006124904, 9884.11043006133, 9920.156786673213, 9943.0, 6703.396694297537, 6960.443164546723, 7304.306090921354, 7461.962690186731, 7546.056742907137, 8154.0, 8215.876761848458, 8221.0, 8228.794280143044, 8241.423100382915, 7141.892871606826, 7228.421726261781, 7239.710411583477, 7344.228855970046, 7396.3343299103335, 7037.26108758573, 7095.680694368662, 7195.532290401107, 7201.171865235565, 7238.6380680966795, 7012.1935977363255, 7540.0951885771865, 7707.421943354383, 7781.533108013311, 7788.299053085249, 6946.895796563157, 7076.32774886385, 7076.823079422849, 7091.078159839188, 7103.502754807114, 6976.7558135465015, 7123.928760712534, 7143.571385716874, 7150.570965742072, 7156.928430715626], "unit": "score", "name": "mootools.html", "value": 4803.149227497024}, {"lowerIsBetter": false, "replicates": [318.60492988694017, 324.14264271003185, 327.5888759606693, 330.41186687695904, 331.4431754652185, 5401.351837779472, 6324.177856878611, 6409.262934762503, 6486.643234622094, 6601.438877695396, 6302.747890084391, 6389.840253993652, 6393.936060639392, 6399.6160230386095, 6406.167198264219, 4423.51341352451, 4558.361829343878, 4670.019295947855, 4726.787294571753, 4792.688475249115, 4208.431861698662, 4672.275797251432, 4770.189067858472, 4803.807847686088, 4819.44576373718, 4700.882477938062, 4701.318308845215, 4716.151092803294, 4724.551167639069, 4732.029933863567, 3838.539375274957, 3887.591802860687, 4711.363965864616, 4742.976285118552, 4757.35775670287, 3931.7051221158526, 3995.200959808021, 4048.9595104048876, 4063.1467391847746, 4076.082881351702, 6208.50331973441, 6320.178376811031, 6326.588771729869, 6328.778492752777, 6332.525060620472, 4846.975765121187, 5582.581306402036, 5592.496675299242, 5601.523870471015, 5618.353889302701, 6481.93518064818, 6779.966100169468, 6892.345227203407, 6901.1718593769065, 6918.688659010357, 3758.7932663703486, 4566.54334566544, 4570.177368073745, 4580.8167673293365, 4585.426821647294, 6972.302769723038, 7189.676464559107, 7235.565866048001, 7321.121465424183, 7346.045014148127, 4480.059187570581, 4525.705829121097, 4544.613707834805, 4549.567791059844, 4553.157665831832, 4631.328457373662, 4631.421072365954, 4633.8841528961375, 4634.189016922092, 4635.420572428447, 5485.725713714299, 5487.533559647474, 5495.313085864267, 5499.312585926759, 5513.2005859150195, 6708.463322934153, 6966.268541803139, 6970.686319115652, 6974.337437943387, 6994.125734283215, 1571.7485202367566, 1602.4151184817458, 1608.8712902967734, 1611.6937781821416, 1612.8870979031356, 997.3118548201718, 1006.3408467453829, 1027.034587487774, 1027.085893554737, 1028.4189432970347, 6314.242290925118, 6465.062565928009, 6471.870562588721, 6494.253160886464, 6500.9349906501275, 7126.251743566954, 7295.963520182365, 7297.0, 7306.561606303639, 7322.743703970335, 6591.077249185118, 6609.107770450928, 6612.933870661328, 6619.801405957829, 6622.768203112868, 3083.799553029046, 3775.8867233983024, 3816.694664426839, 3821.235752849386, 3837.136644255076, 6328.6519241442165, 7176.744069787871, 7614.048243969504, 7623.504472209289, 7633.389328853678, 7413.258674132544, 7473.551586904694, 7488.700451981968, 7490.2135275796345, 7501.137369202612, 7587.506812057309, 7607.239276072349, 7614.124375696755, 7615.200403957616, 7616.0099187105325, 6389.616623002635, 7226.4218862491925, 7231.746888858865, 7235.421166306788, 7245.7826265212125, 5193.870153246199, 5519.834404967857, 7066.152061752417, 7071.292870712888, 7175.067241258603, 7560.243975602396, 7587.734429294948, 7631.3131818136635, 7636.12184598756, 7638.50349727266, 4550.13547425988, 4560.338750881037, 4576.977115114403, 4577.3591697161755, 4587.17430862448, 7252.5648461092505, 7257.52826066304, 7264.891026634499, 7276.527025743309, 7301.488895777245, 6770.32296770319, 6801.421879140131, 7036.401905838061, 7037.507374483942, 7051.929480705127, 5973.313068997121, 6933.757318493828, 7037.120359955005, 7057.153141623038, 7070.611116388648, 6872.381485666314, 6878.965605171942, 6901.1718593769065, 6901.654917254017, 6903.413209877217, 5750.706091129462, 6986.860262794818, 7054.0, 7075.82310442243, 7079.893801592877, 6626.337366263335, 6812.420944219797, 6832.0, 6897.896531552131, 6924.93075069263], "unit": "score", "name": "prototype.html", "value": 5032.49398888154}, {"lowerIsBetter": false, "replicates": [688.2119972631338, 701.8806802843518, 733.3509843788249, 735.955842649441, 758.9544627322365, 15172.620684482894, 15175.54473365798, 15369.308381122863, 15369.769453458208, 15386.461473848418, 14165.504207352744, 14262.072965257252, 14267.429302827875, 14272.0, 14356.569302920929, 714.91063617048, 729.657061181244, 880.3485420788602, 899.5097671768901, 901.8061116859874, 792.5759718550577, 886.1979908183105, 903.70629545398, 904.0959040959041, 904.1230006893303, 946.5361972633394, 947.0671388682142, 947.9052094790535, 950.0831697411996, 950.4867371619317, 751.7519218657857, 768.4735955870219, 768.723259626534, 926.2404828041009, 937.0769791755116, 609.7500024989778, 672.1799404726227, 698.6157613312657, 699.9685014174374, 700.6566782276648, 12821.423035963404, 14670.633234169125, 15074.944753867234, 15124.54626361211, 15125.773113403307, 12555.560555380609, 12750.617481475478, 12864.485420583165, 13045.282509461977, 13353.599392018255, 9917.256205784595, 10109.090181883666, 10201.336913100624, 10371.377717336909, 10867.673969780919, 3428.8114153721535, 3484.1638006878165, 3517.314123745871, 3560.1455650643916, 3760.868369607078, 83981.58009209976, 84041.0, 85692.57153714253, 86074.27851442999, 86472.56763716204, 9478.857817132748, 9658.855117173249, 9719.514024298756, 9927.950360248153, 10019.04438190721, 22743.88628056849, 22760.089596415957, 22785.88607056954, 22805.31584052448, 22822.885885570468, 7452.962735186397, 7508.211637778064, 7562.357199638092, 7568.886466703004, 7743.806404839811, 4022.0749227677798, 4076.3681629347498, 4098.262312783728, 4184.895377615584, 4215.430916826251, 3533.876314328986, 3598.7121030318035, 3598.8200589970397, 3602.9099272518397, 3610.422332426799, 625.9812205633838, 630.1870586942792, 634.6890023888354, 638.8594509207967, 659.307726886767, 534.2040359863774, 584.2521572387351, 603.4177019176516, 612.6048698589385, 638.6072565372262, 7573.772786816405, 7916.1688022757935, 8190.631421586043, 8243.25810677042, 8248.711295104642, 580.7705956147298, 594.1296001358031, 600.7266693654377, 601.9307779605314, 605.8424809549549, 3688.465172550019, 3797.9620203798163, 3817.9427308590393, 3838.808059597065, 3935.4883865097354, 84867.15132848592, 87063.69404458939, 87251.0, 88276.67584986231, 88433.67349489762, 81599.0, 82010.0, 83275.58362208272, 83415.16584834196, 84041.57979210065, 71489.64255178795, 71565.6421717888, 72654.0, 73076.90384644235, 73154.0, 7563.281488258606, 7598.734044308644, 7855.0, 7873.37013038944, 7961.880571791312, 48537.757311213216, 49168.958507712654, 49370.75314623404, 49975.0, 50076.992300769634, 68854.31145688679, 70710.29289707243, 70715.0, 71007.64496177486, 72044.9193262091, 10212.343718991982, 10254.743631408975, 10352.792944140925, 10636.30863993838, 10783.19126065564, 10777.46112694378, 10930.45347732626, 11028.558857645925, 11147.275427097213, 11419.657410277705, 10185.694429167137, 10278.074973252444, 10418.791624167627, 10474.947625261824, 10668.573257069631, 10119.7470063249, 10230.897691023292, 10306.33008854422, 10520.421376824348, 10633.936606339304, 10088.69733907984, 10150.543225555015, 10280.331778434378, 10444.895551044392, 10532.631357902437, 8607.18231767981, 8683.305335573014, 8757.168069033432, 8765.649374025223, 9008.684696035607, 8788.42875213109, 8795.956020219857, 8868.600912959062, 8955.910440895508, 9040.547972601213], "unit": "score", "name": "yui.html", "value": 6789.476024274887}], "name": "dromaeo_css", "value": 7436.15406589153}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 112.0, 111.0, 112.0, 112.0, 117.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [157.0, 120.0, 150.0, 193.0, 142.0, 141.0, 143.0, 118.0, 164.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 144.5}, {"lowerIsBetter": true, "replicates": [186.0, 201.0, 268.0, 204.0, 186.0, 187.0, 185.0, 181.0, 183.0, 183.0], "unit": "score", "name": "audio-dft", "value": 196.4}, {"lowerIsBetter": true, "replicates": [78.0, 75.0, 85.0, 81.0, 58.0, 59.0, 58.0, 75.0, 76.0, 55.0], "unit": "score", "name": "audio-fft", "value": 70.0}, {"lowerIsBetter": true, "replicates": [97.0, 91.0, 130.0, 77.0, 77.0, 82.0, 115.0, 78.0, 78.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 94.2}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 87.0, 88.0, 135.0, 85.0, 88.0, 84.0, 88.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.2}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 94.0, 94.0, 93.0, 92.0, 93.0, 93.0, 92.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 92.9}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 86.0, 85.0, 86.0, 87.0, 85.0, 83.0, 85.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 85.4}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 54.0, 54.0, 55.0, 55.0, 56.0, 65.0, 55.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 64.0, 76.0, 72.0, 68.0, 71.0, 67.0, 68.0, 72.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 83.0, 82.0, 84.0, 84.0, 83.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [121.0, 128.0, 137.0, 139.0, 139.0, 109.0, 123.0, 134.0, 130.0, 140.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.0}, {"lowerIsBetter": true, "replicates": [137.0, 127.0, 141.0, 140.0, 141.0, 130.0, 140.0, 141.0, 139.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.7}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 66.0, 67.0, 68.0, 67.0, 70.0, 83.0, 91.0, 95.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 74.2}], "name": "kraken", "value": 1436.5}]} 14:31:22 INFO - Return code: 0 14:31:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:31:22 ERROR - # TBPL SUCCESS # 14:31:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:31:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:31:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:31:22 INFO - 2016-03-24 14:31:22.939 screenresolution[2325:27393] starting screenresolution argv=screenresolution get 14:31:22 INFO - 2016-03-24 14:31:22.942 screenresolution[2325:27393] Display 0: 1600x1200x32@60 14:31:22 INFO - 2016-03-24 14:31:22.948 screenresolution[2326:27396] starting screenresolution argv=screenresolution list 14:31:22 INFO - Available Modes on Display 0 14:31:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:31:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:31:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:31:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:31:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:31:23 INFO - Intel Iris: 14:31:23 INFO - Chipset Model: Intel Iris 14:31:23 INFO - Type: GPU 14:31:23 INFO - Bus: Built-In 14:31:23 INFO - VRAM (Dynamic, Max): 1536 MB 14:31:23 INFO - Vendor: Intel (0x8086) 14:31:23 INFO - Device ID: 0x0a2e 14:31:23 INFO - Revision ID: 0x0009 14:31:23 INFO - Displays: 14:31:23 INFO - Display: 14:31:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:31:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:31:23 INFO - Display Serial Number: 1600x1200 60 14:31:23 INFO - Main Display: Yes 14:31:23 INFO - Mirror: Off 14:31:23 INFO - Online: Yes 14:31:23 INFO - Rotation: Supported 14:31:23 INFO - Return code: 0 14:31:23 INFO - Running post-action listener: _resource_record_post_action 14:31:23 INFO - Running post-run listener: _resource_record_post_run 14:31:24 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 114688; Write bytes: 702338048; Read time: 3; Write time: 1821 14:31:24 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 383539712; Write bytes: 377104384; Read time: 28543; Write time: 656 14:31:24 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 114688; Write bytes: 298257408; Read time: 3; Write time: 1109 14:31:24 INFO - Running post-run listener: _upload_blobber_files 14:31:24 INFO - Blob upload gear active. 14:31:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:31:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:31:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:31:24 INFO - (blobuploader) - INFO - Open directory for files ... 14:31:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:31:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:31:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:25 INFO - (blobuploader) - INFO - Done attempting. 14:31:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:31:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:31:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:26 INFO - (blobuploader) - INFO - Done attempting. 14:31:26 INFO - (blobuploader) - INFO - Iteration through files over. 14:31:26 INFO - Return code: 0 14:31:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:31:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:31:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d118391dbb5b39daba292baff71791ef298b3914b8b9f862ab21d29ec15051b039a18bff363745ed49da05ab12b6d29a0c6b6c0e1f15aed7af5f9cb16aa16fa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c487fae45b0c1f16ba7a81a32a23582323331cc30ab46b2d5f42fe3e843ba8289dd2cb8887dfdec992016d8f1951378946ec2771a4cff3efdc624bb2677c66a"} 14:31:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:31:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:31:26 INFO - Contents: 14:31:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d118391dbb5b39daba292baff71791ef298b3914b8b9f862ab21d29ec15051b039a18bff363745ed49da05ab12b6d29a0c6b6c0e1f15aed7af5f9cb16aa16fa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c487fae45b0c1f16ba7a81a32a23582323331cc30ab46b2d5f42fe3e843ba8289dd2cb8887dfdec992016d8f1951378946ec2771a4cff3efdc624bb2677c66a"} 14:31:26 INFO - Running post-run listener: copy_logs_to_upload_dir 14:31:26 INFO - Copying logs to upload dir... 14:31:26 INFO - mkdir: /builds/slave/test/build/upload/logs 14:31:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1343.309409 ========= master_lag: 3.45 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 26 secs) (at 2016-03-24 14:31:29.866254) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 14:31:29.869237) ========= 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.kBG0atjFJJ/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.N8X1sbZ8Xa/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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/Fx-Team/sha512/2d118391dbb5b39daba292baff71791ef298b3914b8b9f862ab21d29ec15051b039a18bff363745ed49da05ab12b6d29a0c6b6c0e1f15aed7af5f9cb16aa16fa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c487fae45b0c1f16ba7a81a32a23582323331cc30ab46b2d5f42fe3e843ba8289dd2cb8887dfdec992016d8f1951378946ec2771a4cff3efdc624bb2677c66a"} build_url:https://queue.taskcluster.net/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011193 build_url: 'https://queue.taskcluster.net/v1/task/GHy5vsLPQmWv9slUnLR-9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d118391dbb5b39daba292baff71791ef298b3914b8b9f862ab21d29ec15051b039a18bff363745ed49da05ab12b6d29a0c6b6c0e1f15aed7af5f9cb16aa16fa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c487fae45b0c1f16ba7a81a32a23582323331cc30ab46b2d5f42fe3e843ba8289dd2cb8887dfdec992016d8f1951378946ec2771a4cff3efdc624bb2677c66a"}' ========= master_lag: 0.13 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 14:31:30.006648) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 14:31:30.006977) ========= 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.kBG0atjFJJ/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.N8X1sbZ8Xa/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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.005301 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 14:31:30.027702) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 14:31:30.028015) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 14:31:30.028388) ========= ========= Total master_lag: 8.00 =========