builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0150 starttime: 1459854411.31 results: success (0) buildid: 20160405020119 builduid: 03e53c4abfc04aa298a6c63814ff7928 revision: d9f50aa0a1aaf90499b85c31e0f329b762e80fdd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 04:06:51.312058) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 04:06:51.312509) ========= ========= Started set props: basedir (results: 0, elapsed: 4 secs) (at 2016-04-05 04:06:51.312856) ========= 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.coJ319NwVU/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.qr1EDEz8ZJ/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.005505 basedir: '/builds/slave/test' ========= master_lag: 4.67 ========= ========= Finished set props: basedir (results: 0, elapsed: 4 secs) (at 2016-04-05 04:06:55.991972) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 04:06:55.992293) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 04:06:56.356677) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 04:06:56.356999) ========= 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.coJ319NwVU/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.qr1EDEz8ZJ/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.005677 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 04:06:56.478070) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 04:06:56.478337) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 04:06:56.478663) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-05 04:06:56.479055) ========= 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.coJ319NwVU/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.qr1EDEz8ZJ/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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-04-05 04:06:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2016-04-05 04:06:56 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.189661 ========= master_lag: 0.84 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-05 04:06:57.510849) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 04:06:57.511213) ========= 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.coJ319NwVU/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.qr1EDEz8ZJ/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.026428 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 04:06:57.563431) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 04:06:57.563791) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d9f50aa0a1aaf90499b85c31e0f329b762e80fdd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d9f50aa0a1aaf90499b85c31e0f329b762e80fdd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.coJ319NwVU/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.qr1EDEz8ZJ/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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-04-05 04:06:57,644 truncating revision to first 12 chars 2016-04-05 04:06:57,644 Setting DEBUG logging. 2016-04-05 04:06:57,644 attempt 1/10 2016-04-05 04:06:57,644 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d9f50aa0a1aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-05 04:06:57,971 unpacking tar archive at: mozilla-central-d9f50aa0a1aa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.569466 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 04:06:58.161642) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 04:06:58.162047) ========= echo d9f50aa0a1aaf90499b85c31e0f329b762e80fdd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd9f50aa0a1aaf90499b85c31e0f329b762e80fdd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.coJ319NwVU/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.qr1EDEz8ZJ/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 d9f50aa0a1aaf90499b85c31e0f329b762e80fdd program finished with exit code 0 elapsedTime=0.005895 script_repo_revision: 'd9f50aa0a1aaf90499b85c31e0f329b762e80fdd' ========= master_lag: 0.58 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 04:06:58.751824) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 04:06:58.752186) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 04:06:58.803512) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-04-05 04:06:58.803921) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.coJ319NwVU/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.qr1EDEz8ZJ/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 04:06:58 INFO - MultiFileLogger online at 20160405 04:06:58 in /builds/slave/test 04:06:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:06:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:06:58 INFO - {'append_to_log': False, 04:06:58 INFO - 'base_work_dir': '/builds/slave/test', 04:06:58 INFO - 'blob_upload_branch': 'Firefox', 04:06:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:06:58 INFO - 'branch': 'Firefox', 04:06:58 INFO - 'buildbot_json_path': 'buildprops.json', 04:06:58 INFO - 'config_files': ('talos/mac_config.py',), 04:06:58 INFO - 'default_actions': ('clobber', 04:06:58 INFO - 'read-buildbot-config', 04:06:58 INFO - 'download-and-extract', 04:06:58 INFO - 'populate-webroot', 04:06:58 INFO - 'create-virtualenv', 04:06:58 INFO - 'install', 04:06:58 INFO - 'run-tests'), 04:06:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:06:58 INFO - 'download_minidump_stackwalk': True, 04:06:58 INFO - 'download_symbols': 'ondemand', 04:06:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:06:58 INFO - 'tooltool.py': '/tools/tooltool.py', 04:06:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:06:58 INFO - '/tools/misc-python/virtualenv.py')}, 04:06:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:06:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:06:58 INFO - 'installer_path': 'installer.exe', 04:06:58 INFO - 'log_level': 'info', 04:06:58 INFO - 'log_name': 'talos', 04:06:58 INFO - 'log_to_console': True, 04:06:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:06:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:06:58 INFO - 'opt_config_files': (), 04:06:58 INFO - 'pip_index': False, 04:06:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:06:58 INFO - 'cmd': ('bash', 04:06:58 INFO - '-c', 04:06:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:06:58 INFO - 'enabled': True, 04:06:58 INFO - 'halt_on_failure': False, 04:06:58 INFO - 'name': 'check_screen_resolution'},), 04:06:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:06:58 INFO - 'cmd': ('bash', 04:06:58 INFO - '-c', 04:06:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:06:58 INFO - 'enabled': True, 04:06:58 INFO - 'halt_on_failure': False, 04:06:58 INFO - 'name': 'check_screen_resolution'},), 04:06:58 INFO - 'run_cmd_checks_enabled': True, 04:06:58 INFO - 'sps_profile': False, 04:06:58 INFO - 'sps_profile_interval': 0, 04:06:58 INFO - 'suite': 'dromaeojs', 04:06:58 INFO - 'system_bits': '32', 04:06:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:06:59 INFO - 'title': 't-yosemite-r7-0150', 04:06:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:06:59 INFO - 'use_talos_json': True, 04:06:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:06:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:06:59 INFO - 'work_dir': 'build'} 04:06:59 INFO - ##### 04:06:59 INFO - ##### Running clobber step. 04:06:59 INFO - ##### 04:06:59 INFO - Running pre-action listener: _resource_record_pre_action 04:06:59 INFO - Running main action method: clobber 04:06:59 INFO - rmtree: /builds/slave/test/build 04:06:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:07:00 INFO - Running post-action listener: _resource_record_post_action 04:07:00 INFO - ##### 04:07:00 INFO - ##### Running read-buildbot-config step. 04:07:00 INFO - ##### 04:07:00 INFO - Running pre-action listener: _resource_record_pre_action 04:07:00 INFO - Running main action method: read_buildbot_config 04:07:00 INFO - Using buildbot properties: 04:07:00 INFO - { 04:07:00 INFO - "project": "", 04:07:00 INFO - "product": "firefox", 04:07:00 INFO - "script_repo_revision": "production", 04:07:00 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:07:00 INFO - "repository": "", 04:07:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:07:00 INFO - "buildid": "20160405020119", 04:07:00 INFO - "pgo_build": "False", 04:07:00 INFO - "basedir": "/builds/slave/test", 04:07:00 INFO - "buildnumber": 192, 04:07:00 INFO - "slavename": "t-yosemite-r7-0150", 04:07:00 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:07:00 INFO - "platform": "yosemite_r7", 04:07:00 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:07:00 INFO - "branch": "mozilla-central", 04:07:00 INFO - "repo_path": "mozilla-central", 04:07:00 INFO - "revision": "d9f50aa0a1aaf90499b85c31e0f329b762e80fdd", 04:07:00 INFO - "stage_platform": "macosx64", 04:07:00 INFO - "builduid": "03e53c4abfc04aa298a6c63814ff7928", 04:07:00 INFO - "slavebuilddir": "test" 04:07:00 INFO - } 04:07:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 04:07:00 INFO - Running post-action listener: _resource_record_post_action 04:07:00 INFO - ##### 04:07:00 INFO - ##### Running download-and-extract step. 04:07:00 INFO - ##### 04:07:00 INFO - Running pre-action listener: _resource_record_pre_action 04:07:00 INFO - Running main action method: download_and_extract 04:07:00 INFO - mkdir: /builds/slave/test/build/tests 04:07:00 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')]} 04:07:00 INFO - https://queue.taskcluster.net/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:07:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:07:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:07:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/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 04:07:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/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 04:07:02 INFO - Downloaded 1199 bytes. 04:07:02 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:07:02 INFO - Using the following test package requirements: 04:07:02 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:07:02 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:07:02 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 04:07:02 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:07:02 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 04:07:02 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:07:02 INFO - u'jsshell-mac.zip'], 04:07:02 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:07:02 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 04:07:02 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:07:02 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:07:02 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 04:07:02 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:07:02 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 04:07:02 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:07:02 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 04:07:02 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:07:02 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 04:07:02 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:02 INFO - https://queue.taskcluster.net/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:07:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:07:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:07:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/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 04:07:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/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 04:07:04 INFO - Downloaded 17959933 bytes. 04:07:04 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'] 04:07:04 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 04:07:08 INFO - Return code: 0 04:07:08 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 04:07:08 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')]} 04:07:08 INFO - https://queue.taskcluster.net/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:07:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:07:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:07:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/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 04:07:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/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 04:07:10 INFO - Downloaded 17959933 bytes. 04:07:10 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'] 04:07:10 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 04:07:13 INFO - Return code: 0 04:07:13 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')]} 04:07:13 INFO - https://queue.taskcluster.net/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:07:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:07:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:07:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/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 04:07:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/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 04:07:15 INFO - Downloaded 10847584 bytes. 04:07:15 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'] 04:07:15 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 04:07:15 INFO - Return code: 0 04:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:15 INFO - https://queue.taskcluster.net/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:07:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:07:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:07:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 04:07:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/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 04:07:25 INFO - Downloaded 111354357 bytes. 04:07:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:07:25 INFO - mkdir: /builds/slave/test/properties 04:07:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:07:25 INFO - Writing to file /builds/slave/test/properties/build_url 04:07:25 INFO - Contents: 04:07:25 INFO - build_url:https://queue.taskcluster.net/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:07:26 INFO - Running post-action listener: _resource_record_post_action 04:07:26 INFO - Running post-action listener: set_extra_try_arguments 04:07:26 INFO - ##### 04:07:26 INFO - ##### Running populate-webroot step. 04:07:26 INFO - ##### 04:07:26 INFO - Running pre-action listener: _resource_record_pre_action 04:07:26 INFO - Running main action method: populate_webroot 04:07:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:07:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:07:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:07:26 INFO - '--tppagecycles', 04:07:26 INFO - '7'], 04:07:26 INFO - 'tests': ['tsvgm']}}, 04:07:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:07:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:07:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:07:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:07:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:07:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:07:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:07:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:26 INFO - 'talos_options': ['--e10s'], 04:07:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:07:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:26 INFO - 'tests': ['damp', 'tps']}, 04:07:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:26 INFO - 'talos_options': ['--e10s'], 04:07:26 INFO - 'tests': ['damp', 'tps']}, 04:07:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:07:26 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 04:07:26 INFO - 'tests': ['dromaeo_dom']}, 04:07:26 INFO - 'other': {'tests': ['a11yr', 04:07:26 INFO - 'ts_paint', 04:07:26 INFO - 'tpaint', 04:07:26 INFO - 'sessionrestore', 04:07:26 INFO - 'sessionrestore_no_auto_restore', 04:07:26 INFO - 'tabpaint']}, 04:07:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:07:26 INFO - 'tests': ['a11yr', 04:07:26 INFO - 'ts_paint', 04:07:26 INFO - 'tpaint', 04:07:26 INFO - 'sessionrestore', 04:07:26 INFO - 'sessionrestore_no_auto_restore', 04:07:26 INFO - 'tabpaint']}, 04:07:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:07:26 INFO - 'tests': ['a11yr', 04:07:26 INFO - 'ts_paint', 04:07:26 INFO - 'tpaint', 04:07:26 INFO - 'sessionrestore', 04:07:26 INFO - 'sessionrestore_no_auto_restore', 04:07:26 INFO - 'tabpaint']}, 04:07:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:07:26 INFO - 'tests': ['a11yr', 04:07:26 INFO - 'ts_paint', 04:07:26 INFO - 'tpaint', 04:07:26 INFO - 'sessionrestore', 04:07:26 INFO - 'sessionrestore_no_auto_restore', 04:07:26 INFO - 'tabpaint']}, 04:07:26 INFO - 'other_l64': {'tests': ['a11yr', 04:07:26 INFO - 'ts_paint', 04:07:26 INFO - 'tpaint', 04:07:26 INFO - 'sessionrestore', 04:07:26 INFO - 'sessionrestore_no_auto_restore', 04:07:26 INFO - 'tabpaint']}, 04:07:26 INFO - 'other_nol64': {'tests': ['a11yr', 04:07:26 INFO - 'ts_paint', 04:07:26 INFO - 'tpaint', 04:07:26 INFO - 'sessionrestore', 04:07:26 INFO - 'sessionrestore_no_auto_restore', 04:07:26 INFO - 'tabpaint']}, 04:07:26 INFO - 'svgr': {'tests': ['tsvgx', 04:07:26 INFO - 'tsvgr_opacity', 04:07:26 INFO - 'tart', 04:07:26 INFO - 'tscrollx', 04:07:26 INFO - 'cart']}, 04:07:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:07:26 INFO - 'tests': ['tsvgx', 04:07:26 INFO - 'tsvgr_opacity', 04:07:26 INFO - 'tart', 04:07:26 INFO - 'tscrollx', 04:07:26 INFO - 'cart']}, 04:07:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:26 INFO - 'tests': ['tp5o']}, 04:07:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:26 INFO - 'talos_options': ['--e10s'], 04:07:26 INFO - 'tests': ['tp5o']}, 04:07:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:26 INFO - 'talos_options': ['--xperf_path', 04:07:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:07:26 INFO - 'tests': ['tp5n']}, 04:07:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:26 INFO - 'talos_options': ['--e10s', 04:07:26 INFO - '--xperf_path', 04:07:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:07:26 INFO - 'tests': ['tp5n']}}, 04:07:26 INFO - 'talos.zip': {'path': '', 04:07:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:07:26 INFO - Running post-action listener: _resource_record_post_action 04:07:26 INFO - ##### 04:07:26 INFO - ##### Running create-virtualenv step. 04:07:26 INFO - ##### 04:07:26 INFO - Running pre-action listener: _resource_record_pre_action 04:07:26 INFO - Running main action method: create_virtualenv 04:07:26 INFO - Creating virtualenv /builds/slave/test/build/venv 04:07:26 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 04:07:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:07:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:07:26 INFO - Using real prefix '/tools/python27' 04:07:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:07:27 INFO - Installing distribute.............................................................................................................................................................................................done. 04:07:30 INFO - Installing pip.................done. 04:07:30 INFO - Return code: 0 04:07:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:07:30 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')]} 04:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:30 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')]} 04:07:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:30 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 0x10c81ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c82e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7acc84b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bde00>, '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 0x10c4e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6b8b20>, '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.coJ319NwVU/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.qr1EDEz8ZJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 04:07:30 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 04:07:30 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 04:07:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.coJ319NwVU/Render', 04:07:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:30 INFO - 'HOME': '/Users/cltbld', 04:07:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:30 INFO - 'LOGNAME': 'cltbld', 04:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:30 INFO - 'MOZ_NO_REMOTE': '1', 04:07:30 INFO - 'NO_EM_RESTART': '1', 04:07:30 INFO - 'PAGER': '/bin/cat', 04:07:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:30 INFO - 'PWD': '/builds/slave/test', 04:07:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:30 INFO - 'SHELL': '/bin/bash', 04:07:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qr1EDEz8ZJ/Listeners', 04:07:30 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 04:07:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:30 INFO - 'USER': 'cltbld', 04:07:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:30 INFO - 'XPC_FLAGS': '0x0', 04:07:30 INFO - 'XPC_SERVICE_NAME': '0', 04:07:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:30 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 04:07:30 INFO - Cleaning up... 04:07:30 INFO - Return code: 0 04:07:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:07:30 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')]} 04:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:30 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')]} 04:07:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:30 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 0x10c81ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c82e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7acc84b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bde00>, '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 0x10c4e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6b8b20>, '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.coJ319NwVU/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.qr1EDEz8ZJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 04:07:30 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 04:07:30 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 04:07:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.coJ319NwVU/Render', 04:07:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:30 INFO - 'HOME': '/Users/cltbld', 04:07:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:30 INFO - 'LOGNAME': 'cltbld', 04:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:30 INFO - 'MOZ_NO_REMOTE': '1', 04:07:30 INFO - 'NO_EM_RESTART': '1', 04:07:30 INFO - 'PAGER': '/bin/cat', 04:07:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:30 INFO - 'PWD': '/builds/slave/test', 04:07:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:30 INFO - 'SHELL': '/bin/bash', 04:07:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qr1EDEz8ZJ/Listeners', 04:07:30 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 04:07:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:30 INFO - 'USER': 'cltbld', 04:07:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:30 INFO - 'XPC_FLAGS': '0x0', 04:07:30 INFO - 'XPC_SERVICE_NAME': '0', 04:07:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:30 INFO - Downloading/unpacking psutil>=0.7.1 04:07:30 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 04:07:30 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 04:07:30 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 04:07:30 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 04:07:30 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 04:07:30 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 04:07:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:07:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:33 INFO - Installing collected packages: psutil 04:07:33 INFO - Running setup.py install for psutil 04:07:33 INFO - building 'psutil._psutil_osx' extension 04:07:33 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 04:07:34 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 04:07:34 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 04:07:34 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 04:07:34 INFO - building 'psutil._psutil_posix' extension 04:07:34 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 04:07:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:07:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:07:34 INFO - ^ 04:07:34 INFO - 1 warning generated. 04:07:34 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 04:07:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:34 INFO - Successfully installed psutil 04:07:34 INFO - Cleaning up... 04:07:34 INFO - Return code: 0 04:07:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c81ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c82e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7acc84b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bde00>, '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 0x10c4e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6b8b20>, '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.coJ319NwVU/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.qr1EDEz8ZJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 04:07:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:07:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:07:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.coJ319NwVU/Render', 04:07:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:35 INFO - 'HOME': '/Users/cltbld', 04:07:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:35 INFO - 'LOGNAME': 'cltbld', 04:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:35 INFO - 'MOZ_NO_REMOTE': '1', 04:07:35 INFO - 'NO_EM_RESTART': '1', 04:07:35 INFO - 'PAGER': '/bin/cat', 04:07:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:35 INFO - 'PWD': '/builds/slave/test', 04:07:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:35 INFO - 'SHELL': '/bin/bash', 04:07:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qr1EDEz8ZJ/Listeners', 04:07:35 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 04:07:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:35 INFO - 'USER': 'cltbld', 04:07:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:35 INFO - 'XPC_FLAGS': '0x0', 04:07:35 INFO - 'XPC_SERVICE_NAME': '0', 04:07:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:07:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:07:38 INFO - Installing collected packages: mozsystemmonitor 04:07:38 INFO - Running setup.py install for mozsystemmonitor 04:07:38 INFO - Successfully installed mozsystemmonitor 04:07:38 INFO - Cleaning up... 04:07:38 INFO - Return code: 0 04:07:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c81ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c82e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7acc84b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bde00>, '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 0x10c4e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6b8b20>, '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.coJ319NwVU/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.qr1EDEz8ZJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 04:07:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:07:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:07:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.coJ319NwVU/Render', 04:07:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:38 INFO - 'HOME': '/Users/cltbld', 04:07:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:38 INFO - 'LOGNAME': 'cltbld', 04:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:38 INFO - 'MOZ_NO_REMOTE': '1', 04:07:38 INFO - 'NO_EM_RESTART': '1', 04:07:38 INFO - 'PAGER': '/bin/cat', 04:07:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:38 INFO - 'PWD': '/builds/slave/test', 04:07:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:38 INFO - 'SHELL': '/bin/bash', 04:07:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qr1EDEz8ZJ/Listeners', 04:07:38 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 04:07:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:38 INFO - 'USER': 'cltbld', 04:07:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:38 INFO - 'XPC_FLAGS': '0x0', 04:07:38 INFO - 'XPC_SERVICE_NAME': '0', 04:07:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:38 INFO - Downloading/unpacking blobuploader==1.2.4 04:07: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 04:07: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 04:07: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 04:07: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 04:07: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 04:07: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 04:07:40 INFO - Downloading blobuploader-1.2.4.tar.gz 04:07:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:07:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:07:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:42 INFO - Downloading docopt-0.6.1.tar.gz 04:07:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:07:42 INFO - Installing collected packages: blobuploader, requests, docopt 04:07:42 INFO - Running setup.py install for blobuploader 04:07:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:07:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:07:42 INFO - Running setup.py install for requests 04:07:42 INFO - Running setup.py install for docopt 04:07:43 INFO - Successfully installed blobuploader requests docopt 04:07:43 INFO - Cleaning up... 04:07:43 INFO - Return code: 0 04:07:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:43 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')]} 04:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:43 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')]} 04:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:43 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 0x10c81ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c82e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7acc84b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bde00>, '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 0x10c4e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6b8b20>, '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.coJ319NwVU/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.qr1EDEz8ZJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 04:07:43 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 04:07:43 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 04:07:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.coJ319NwVU/Render', 04:07:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:43 INFO - 'HOME': '/Users/cltbld', 04:07:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:43 INFO - 'LOGNAME': 'cltbld', 04:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:43 INFO - 'MOZ_NO_REMOTE': '1', 04:07:43 INFO - 'NO_EM_RESTART': '1', 04:07:43 INFO - 'PAGER': '/bin/cat', 04:07:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:43 INFO - 'PWD': '/builds/slave/test', 04:07:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:43 INFO - 'SHELL': '/bin/bash', 04:07:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qr1EDEz8ZJ/Listeners', 04:07:43 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 04:07:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:43 INFO - 'USER': 'cltbld', 04:07:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:43 INFO - 'XPC_FLAGS': '0x0', 04:07:43 INFO - 'XPC_SERVICE_NAME': '0', 04:07:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:07:43 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-BmnbFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:07:43 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-zNfA2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:07:43 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-qx_ipf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:07:43 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-QXkuiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:07:43 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-7Tmzom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:07:43 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-KTAnSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:07:44 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-pzsf13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:07:44 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-IKD4t5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:07:44 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-v2FQZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:07:44 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-faVC6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:07:44 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-ayldjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:07:44 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-H8GMvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:07:44 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-m29ZO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:07:44 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-K9vf62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:44 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-3mEKzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:07:44 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-FiSuHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:07:45 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-TedlbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:07:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:07:45 INFO - Running setup.py install for manifestparser 04:07:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:07:45 INFO - Running setup.py install for mozcrash 04:07:45 INFO - Running setup.py install for mozdebug 04:07:45 INFO - Running setup.py install for mozdevice 04:07:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:07:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:07:45 INFO - Running setup.py install for mozfile 04:07:45 INFO - Running setup.py install for mozhttpd 04:07:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:07:46 INFO - Running setup.py install for mozinfo 04:07:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:07:46 INFO - Running setup.py install for mozInstall 04:07:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:07:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:07:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:07:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:07:46 INFO - Running setup.py install for mozleak 04:07:46 INFO - Running setup.py install for mozlog 04:07:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:07:46 INFO - Running setup.py install for moznetwork 04:07:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:07:46 INFO - Running setup.py install for mozprocess 04:07:46 INFO - Running setup.py install for mozprofile 04:07:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:07:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:07:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:07:47 INFO - Running setup.py install for mozrunner 04:07:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:07:47 INFO - Running setup.py install for mozscreenshot 04:07:47 INFO - Running setup.py install for moztest 04:07:47 INFO - Running setup.py install for mozversion 04:07:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:07:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:07:47 INFO - Cleaning up... 04:07:47 INFO - Return code: 0 04:07:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:47 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 0x10c81ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c82e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7acc84b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bde00>, '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 0x10c4e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6b8b20>, '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.coJ319NwVU/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.qr1EDEz8ZJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 04:07:47 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 04:07:47 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 04:07:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.coJ319NwVU/Render', 04:07:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:47 INFO - 'HOME': '/Users/cltbld', 04:07:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:47 INFO - 'LOGNAME': 'cltbld', 04:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:47 INFO - 'MOZ_NO_REMOTE': '1', 04:07:47 INFO - 'NO_EM_RESTART': '1', 04:07:47 INFO - 'PAGER': '/bin/cat', 04:07:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:47 INFO - 'PWD': '/builds/slave/test', 04:07:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:47 INFO - 'SHELL': '/bin/bash', 04:07:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qr1EDEz8ZJ/Listeners', 04:07:47 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 04:07:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:47 INFO - 'USER': 'cltbld', 04:07:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:47 INFO - 'XPC_FLAGS': '0x0', 04:07:47 INFO - 'XPC_SERVICE_NAME': '0', 04:07:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:07:48 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-_LxgaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:07:48 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)) 04:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:07:48 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-XFunNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:07:48 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)) 04:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:07:48 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-SWN_a6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:07:48 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)) 04:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:07:48 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-HFJ18o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:07:48 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)) 04:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:07:48 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-c2r_3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:07:48 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)) 04:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:07:48 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-pfpJhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:07:48 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)) 04:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:07:48 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Wr9sro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:07:48 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)) 04:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:07:48 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-u4CLEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:07:48 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)) 04:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:07:48 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-E4u_Hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:07:48 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)) 04:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:07:48 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-mPbe7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:07:49 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)) 04:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:07:49 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-ujTpy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:07:49 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)) 04:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:07:49 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-1Dtfbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:07:49 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)) 04:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:07:49 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-r8JVAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:07:49 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)) 04:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:07:49 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-b2wXUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:07:49 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)) 04:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:49 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-QfaXPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:49 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)) 04:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:07:49 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-dzsUZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:07:49 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)) 04:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:07:49 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-RkGz8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:07:49 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)) 04:07:49 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)) 04:07:49 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)) 04:07:49 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)) 04:07:49 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)) 04:07:49 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)) 04:07:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:52 INFO - Downloading blessings-1.6.tar.gz 04:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:07:52 INFO - Installing collected packages: blessings 04:07:52 INFO - Running setup.py install for blessings 04:07:52 INFO - Successfully installed blessings 04:07:52 INFO - Cleaning up... 04:07:52 INFO - Return code: 0 04:07:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:07:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:52 INFO - Reading from file tmpfile_stdout 04:07:52 INFO - Current package versions: 04:07:52 INFO - blessings == 1.6 04:07:52 INFO - blobuploader == 1.2.4 04:07:52 INFO - docopt == 0.6.1 04:07:52 INFO - manifestparser == 1.1 04:07:52 INFO - mozInstall == 1.12 04:07:52 INFO - mozcrash == 0.17 04:07:52 INFO - mozdebug == 0.1 04:07:52 INFO - mozdevice == 0.48 04:07:52 INFO - mozfile == 1.2 04:07:52 INFO - mozhttpd == 0.7 04:07:52 INFO - mozinfo == 0.9 04:07:52 INFO - mozleak == 0.1 04:07:52 INFO - mozlog == 3.1 04:07:52 INFO - moznetwork == 0.27 04:07:52 INFO - mozprocess == 0.22 04:07:52 INFO - mozprofile == 0.28 04:07:52 INFO - mozrunner == 6.11 04:07:52 INFO - mozscreenshot == 0.1 04:07:52 INFO - mozsystemmonitor == 0.0 04:07:52 INFO - moztest == 0.7 04:07:52 INFO - mozversion == 1.4 04:07:52 INFO - psutil == 3.1.1 04:07:52 INFO - requests == 1.2.3 04:07:52 INFO - wsgiref == 0.1.2 04:07:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:52 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 0x10c81ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c82e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7acc84b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bde00>, '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 0x10c4e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6b8b20>, '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.coJ319NwVU/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.qr1EDEz8ZJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 04:07:52 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 04:07:52 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 04:07:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.coJ319NwVU/Render', 04:07:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:52 INFO - 'HOME': '/Users/cltbld', 04:07:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:52 INFO - 'LOGNAME': 'cltbld', 04:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:52 INFO - 'MOZ_NO_REMOTE': '1', 04:07:52 INFO - 'NO_EM_RESTART': '1', 04:07:52 INFO - 'PAGER': '/bin/cat', 04:07:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:52 INFO - 'PWD': '/builds/slave/test', 04:07:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:52 INFO - 'SHELL': '/bin/bash', 04:07:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qr1EDEz8ZJ/Listeners', 04:07:52 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 04:07:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:52 INFO - 'USER': 'cltbld', 04:07:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:52 INFO - 'XPC_FLAGS': '0x0', 04:07:52 INFO - 'XPC_SERVICE_NAME': '0', 04:07:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:53 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)) 04:07:53 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)) 04:07:53 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)) 04:07:53 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)) 04:07:53 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)) 04:07:53 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)) 04:07:53 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)) 04:07:53 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)) 04:07:53 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)) 04:07:53 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)) 04:07:53 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)) 04:07:53 INFO - Cleaning up... 04:07:53 INFO - Return code: 0 04:07:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c81ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c82e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7acc84b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bde00>, '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 0x10c4e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6b8b20>, '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.coJ319NwVU/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.qr1EDEz8ZJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 04:07:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:07:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.coJ319NwVU/Render', 04:07:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:53 INFO - 'HOME': '/Users/cltbld', 04:07:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:53 INFO - 'LOGNAME': 'cltbld', 04:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:53 INFO - 'MOZ_NO_REMOTE': '1', 04:07:53 INFO - 'NO_EM_RESTART': '1', 04:07:53 INFO - 'PAGER': '/bin/cat', 04:07:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:53 INFO - 'PWD': '/builds/slave/test', 04:07:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:53 INFO - 'SHELL': '/bin/bash', 04:07:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qr1EDEz8ZJ/Listeners', 04:07:53 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 04:07:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:53 INFO - 'USER': 'cltbld', 04:07:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:53 INFO - 'XPC_FLAGS': '0x0', 04:07:53 INFO - 'XPC_SERVICE_NAME': '0', 04:07:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:53 INFO - Downloading/unpacking jsonschema 04:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:07:55 INFO - Downloading/unpacking functools32 (from jsonschema) 04:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:56 INFO - Downloading functools32-3.2.3-2.tar.gz 04:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:07:56 INFO - warning: no files found matching '*.txt' 04:07:56 INFO - no previously-included directories found matching 'build' 04:07:56 INFO - no previously-included directories found matching 'dist' 04:07:56 INFO - no previously-included directories found matching '.git*' 04:07:56 INFO - Installing collected packages: jsonschema, functools32 04:07:56 INFO - Running setup.py install for functools32 04:07:56 INFO - warning: no files found matching '*.txt' 04:07:56 INFO - no previously-included directories found matching 'build' 04:07:56 INFO - no previously-included directories found matching 'dist' 04:07:56 INFO - no previously-included directories found matching '.git*' 04:07:56 INFO - Successfully installed jsonschema functools32 04:07:56 INFO - Cleaning up... 04:07:56 INFO - Return code: 0 04:07:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:07:56 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')]} 04:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:56 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')]} 04:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:56 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 0x10c81ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c82e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7acc84b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bde00>, '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 0x10c4e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6b8b20>, '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.coJ319NwVU/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.qr1EDEz8ZJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 04:07:56 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 04:07:56 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 04:07:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.coJ319NwVU/Render', 04:07:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:56 INFO - 'HOME': '/Users/cltbld', 04:07:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:56 INFO - 'LOGNAME': 'cltbld', 04:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:56 INFO - 'MOZ_NO_REMOTE': '1', 04:07:56 INFO - 'NO_EM_RESTART': '1', 04:07:56 INFO - 'PAGER': '/bin/cat', 04:07:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:56 INFO - 'PWD': '/builds/slave/test', 04:07:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:56 INFO - 'SHELL': '/bin/bash', 04:07:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qr1EDEz8ZJ/Listeners', 04:07:56 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 04:07:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:56 INFO - 'USER': 'cltbld', 04:07:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:56 INFO - 'XPC_FLAGS': '0x0', 04:07:56 INFO - 'XPC_SERVICE_NAME': '0', 04:07:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:56 INFO - Downloading/unpacking flake8 04:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:07:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:07:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:08:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:08:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:08:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:08:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:08:00 INFO - no previously-included directories found matching 'docs/_build' 04:08:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:08:00 INFO - Running setup.py install for pep8 04:08:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:08:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:08:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:08:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:08:00 INFO - no previously-included directories found matching 'docs/_build' 04:08:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:08:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:08:00 INFO - Cleaning up... 04:08:00 INFO - Return code: 0 04:08:00 INFO - Running post-action listener: _resource_record_post_action 04:08:00 INFO - Running post-action listener: _start_resource_monitoring 04:08:00 INFO - Starting resource monitoring. 04:08:00 INFO - ##### 04:08:00 INFO - ##### Running install step. 04:08:00 INFO - ##### 04:08:00 INFO - Running pre-action listener: _resource_record_pre_action 04:08:00 INFO - Running main action method: install 04:08:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:08:01 INFO - Reading from file tmpfile_stdout 04:08:01 INFO - Detecting whether we're running mozinstall >=1.0... 04:08:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:08:01 INFO - Reading from file tmpfile_stdout 04:08:01 INFO - Output received: 04:08:01 INFO - Usage: mozinstall [options] installer 04:08:01 INFO - Options: 04:08:01 INFO - -h, --help show this help message and exit 04:08:01 INFO - -d DEST, --destination=DEST 04:08:01 INFO - Directory to install application into. [default: 04:08:01 INFO - "/builds/slave/test"] 04:08:01 INFO - --app=APP Application being installed. [default: firefox] 04:08:01 INFO - mkdir: /builds/slave/test/build/application 04:08:01 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'] 04:08:01 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 04:08:35 INFO - Reading from file tmpfile_stdout 04:08:35 INFO - Output received: 04:08:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:08:35 INFO - Running post-action listener: _resource_record_post_action 04:08:35 INFO - ##### 04:08:35 INFO - ##### Running run-tests step. 04:08:35 INFO - ##### 04:08:35 INFO - Running pre-action listener: _resource_record_pre_action 04:08:35 INFO - Running main action method: run_tests 04:08:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:08:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:08:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:08:35 INFO - 2016-04-05 04:08:35.458 screenresolution[1643:7791] starting screenresolution argv=screenresolution get 04:08:35 INFO - 2016-04-05 04:08:35.461 screenresolution[1643:7791] Display 0: 1600x1200x32@60 04:08:35 INFO - 2016-04-05 04:08:35.466 screenresolution[1644:7793] starting screenresolution argv=screenresolution list 04:08:35 INFO - Available Modes on Display 0 04:08:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:08:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:08:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:08:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:08:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:08:35 INFO - Intel Iris: 04:08:35 INFO - Chipset Model: Intel Iris 04:08:35 INFO - Type: GPU 04:08:35 INFO - Bus: Built-In 04:08:35 INFO - VRAM (Dynamic, Max): 1536 MB 04:08:35 INFO - Vendor: Intel (0x8086) 04:08:35 INFO - Device ID: 0x0a2e 04:08:35 INFO - Revision ID: 0x0009 04:08:35 INFO - Displays: 04:08:35 INFO - Display: 04:08:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:08:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:08:35 INFO - Display Serial Number: 1600x1200 60 04:08:35 INFO - Main Display: Yes 04:08:35 INFO - Mirror: Off 04:08:35 INFO - Online: Yes 04:08:35 INFO - Rotation: Supported 04:08:35 INFO - Return code: 0 04:08:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:08:35 INFO - Python 2.7.3 04:08:35 INFO - Return code: 0 04:08:35 INFO - grabbing minidump binary from tooltool 04:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:35 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 0x10c6bde00>, '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 0x10c4e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6b8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:08:35 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 04:08:35 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 04:08:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:08:35 INFO - Return code: 0 04:08:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:08:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:08:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:08:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:08:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:08:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:08:36 INFO - Return code: 0 04:08:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0150', '--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 04:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0150 --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 04:08:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.coJ319NwVU/Render', 04:08:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:36 INFO - 'HOME': '/Users/cltbld', 04:08:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:36 INFO - 'LOGNAME': 'cltbld', 04:08:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:08:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:36 INFO - 'MOZ_NO_REMOTE': '1', 04:08:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:08:36 INFO - 'NO_EM_RESTART': '1', 04:08:36 INFO - 'PAGER': '/bin/cat', 04:08:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:36 INFO - 'PWD': '/builds/slave/test', 04:08:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:08:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:36 INFO - 'SHELL': '/bin/bash', 04:08:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qr1EDEz8ZJ/Listeners', 04:08:36 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 04:08:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:37 INFO - 'USER': 'cltbld', 04:08:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:37 INFO - 'XPC_FLAGS': '0x0', 04:08:37 INFO - 'XPC_SERVICE_NAME': '0', 04:08:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0150', '--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 04:08:37 INFO - mozversion application_buildid: 20160405020119 04:08:37 INFO - mozversion application_changeset: d9f50aa0a1aaf90499b85c31e0f329b762e80fdd 04:08:37 INFO - mozversion application_display_name: Nightly 04:08:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:08:37 INFO - mozversion application_name: Firefox 04:08:37 INFO - mozversion application_remotingname: firefox 04:08:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:08:37 INFO - mozversion application_vendor: Mozilla 04:08:37 INFO - mozversion application_version: 48.0a1 04:08:37 INFO - mozversion platform_buildid: 20160405020119 04:08:37 INFO - mozversion platform_changeset: d9f50aa0a1aaf90499b85c31e0f329b762e80fdd 04:08:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:08:37 INFO - mozversion platform_version: 48.0a1 04:08:37 INFO - using testdate: 1459854517 04:08:37 INFO - actual date: 1459854517 04:08:37 INFO - starting webserver on 'localhost:49275' 04:08:37 INFO - SUITE-START | Running 2 tests 04:08:37 INFO - TEST-START | dromaeo_css 04:08:37 INFO - operating with platform_type : mac_ 04:08:37 INFO - Initialising browser for dromaeo_css test... 04:08:37 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpfWfHwI/profile http://localhost:49275/getInfo.html) 04:08:39 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 04:08:39 INFO - PROCESS | 1662 | colorDepth:24 04:08:39 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 04:08:39 INFO - PROCESS | 1662 | __metrics 04:08:39 INFO - PROCESS | 1662 | 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" 04:08:39 ERROR - PROCESS | 1662 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:08:40 INFO - TEST-INFO | 1662: exit 0 04:08:40 INFO - Browser initialized. 04:08:40 INFO - Running cycle 1/1 for dromaeo_css test... 04:08:40 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpfWfHwI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:08:51 INFO - PROCESS | 1663 | RSS: Main: 236085248 04:08:52 INFO - PROCESS | 1663 | 04:09:43 INFO - PROCESS | 1663 | 1459854583162 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] 04:11:52 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 04:11:55 INFO - PROCESS | 1663 | RSS: Main: 432136192 04:11:55 INFO - PROCESS | 1663 | 04:14:57 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 04:14:58 INFO - PROCESS | 1663 | RSS: Main: 366997504 04:14:58 INFO - PROCESS | 1663 | 04:18:00 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 04:18:00 INFO - PROCESS | 1663 | RSS: Main: 365555712 04:18:00 INFO - PROCESS | 1663 | 04:21:02 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 04:21:03 INFO - PROCESS | 1663 | RSS: Main: 323776512 04:21:03 INFO - PROCESS | 1663 | 04:24:06 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 04:24:07 INFO - PROCESS | 1663 | RSS: Main: 325337088 04:24:07 INFO - PROCESS | 1663 | 04:27:09 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 04:27:10 INFO - PROCESS | 1663 | RSS: Main: 383483904 04:27:10 INFO - PROCESS | 1663 | 04:27:10 INFO - PROCESS | 1663 | __start_tp_report 04:27:10 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 04:27:10 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 04:27:10 INFO - PROCESS | 1663 | |i|pagename|runs| 04:27:10 INFO - PROCESS | 1663 | |0;dojo.html;3416.6924976752093;3462.0825481247475;3499.9650003499964;3502.719782417407;3525.6298088700687;5380.865478363033;5636.957162924851;5678.772849086036;5714.599978001536;5722.713864306778;4629.259318509039;5734.770609175638;5734.913976290349;5799.304083509975;5837.9124313135335;4276.486821581399;5142.768575414116;5153.510416510426;5157.174852023677;5310;5286.3392075990505;5316.9734151329185;5337.359516857963;5337.919931201035;5377.139657654776;5151.227315902607;5162.716050617233;5264.131418315973;5267.1835865440535;5300.920486192691;4277.230098582254;5264.842054738364;5268.209768534713;5315.01672190646;5327.254184414185;5163.66436181647;5220.712860792655;5233.136532472137;5264.394594621629;5271.65734227274;5552.111662134039;5644.491995720405;5670.659760414388;5673.234113394721;5679.545636349082;6137.969310153465;6249.250089989185;6252.406021427957;6256.968715156395;6278.340774218687;6261.186045814015;6284.2458904931245;6308.400701933355;6313.747450102036;6333.936660633381;5701.857453563611;5716.228309178291;5822.796202132948;5833.241678581757;5835.095560188135;6229.4393504584805;6285.340039295899;6293.30773614902;6295.559310848288;6307.117003619405;6093.817185484442;6182.752689892444;6183.907241391383;6187.907181392283;6205.007198848162;6069.514438844882;6132.692058233643;6269.12232287471;6278.215223097113;6284.277308109535;6159.476444502178;6181.320054793969;6199.473044791243;6205.069239614094;6212.937870621236;6165.938340616536;6230.59501132425;6233.283172435137;6234.251889773256;6236.908541005306;4817.181079216542;4844.806207751651;4883.877903052452;4890.266460031024;4927.260910863328;4378.452693413324;4391.67062470316;4409.889752756207;4420.80106395213;4461.063176732922;5598.300212473441;5639.407862174495;5643.125315576092;5650.124230744241;5670.489655930986;6138.539609529304;6179.84550386244;6201.410865967726;6267.96866015667;6290.308066112724;5596.1605759136455;5621.690807005572;5628.943710562924;5631.352394474606;5642.633228840113;5303.575713942875;5310.283111779938;5312.096943519611;5314.707691077027;5356.303680521507;6180.721867516063;6211.596246243979;6216.098665693449;6252.499800015897;6258.499320054385;6287.434130928238;6297.464715499051;6298.11826344303;6306;6322.652254126067;6239.4696450800375;6279.277883043508;6281.152044473937;6297.55917085818;6310;5968.582199246011;6141.9385806143155;6177.382261773966;6209.875802484015;6220.813375598739;6251.437370636664;6289.49684025286;6290.182276304051;6292.024736165901;6303.149074874833;5942.821715348547;6117.357677443804;6147.692615369124;6155.4767844731905;6182.629042257479;5991.820245392645;6082.330943596289;6110.816675499742;6116.938830611637;6117.847053823512;5916.437938395846;5924.911126333022;5931.703414829155;5946.881062378641;5956.166136740773;6062.302835174011;6079.544034197541;6098.512119030555;6109.877802444015;6123.4488895999575;4874.926876096791;5913.379095194942;5927;5931.288245410578;6075.149479072845 04:27:10 INFO - PROCESS | 1663 | |1;ext.html;501.5536172806201;545.3700975373445;584.6024703201821;637.646106410942;641.9582727122737;38060.61939380609;38398.23203535927;38594.614053859455;38596.807015964914;38600.22799544007;40083;40580;40588.39117413241;40678;40775;9224.354295199355;9477.715668529921;9480.525973701322;9481.66814161501;9484.90515094847;9481.952590237039;9652.95173524135;9671.226301895831;9675.177609903167;9703.029697030275;9582;9655.565499552502;9666.178374838148;9671.323007389485;9676.806463870718;9459.763505912339;9498.430094194371;9545.570449329762;9637;9640.75898102546;9472;9627.277954153396;9636;9651.710448686481;9662.613495460244;38842.805785970886;39211;39340.803295983336;39394.60605393938;39421.014474638076;3228.580284563015;3422.3326451342;3580.9283814323567;3847.076701591598;4136.937945930814;28715.13854584366;28799.712002880122;28919.710802891914;29307.85346073256;29672.554911676343;2759.11708253359;2759.9586006209925;2759.986200069007;2844.1609725131134;2887.63904511936;477396;477651;478773;479854;481008.594957023;46609.5339046612;69563.65218173977;70088;70208.6489567559;70245;45852.77073614678;46112.84717882013;46169.30746038812;46259.76870115628;46320.7683961578;15534.611634708997;15964.92017539905;15969.760453593206;15981.520554383387;16011.679766404606;12593.622191334274;12667.936660316824;12674.873251267369;12771.169873958162;12772.978161747038;15015.549533514011;15055.924720376328;15079.849201508065;15110.924445377703;15233.086014839146;6211.409916057967;6334.176557047646;6379.767081521523;6396.5202609804455;6401.327860574573;920.2362039507193;974.9658761943298;1009.8535712321819;1060.6764936694228;1089.2810744908322;23944.28167154988;29062.982795602053;29517.042366265126;29734.702652973192;29945.70054299429;1039.667306461925;1097.9945100274447;1145.7651181507938;1174.4949671641277;1244.9813252801216;14899.553013409615;15019.849801501845;15035.398584056515;15349.846501534841;15371.538853834403;480904;483520;484437;484766;486188;58553;59959.700201498716;60181.69909150426;60211.09683354753;60260.69869650711;1329.7207586406769;1342.3355439057534;1395.2465668538875;1428.4643258777958;1474.3733913086894;28588.42823143567;29879;30838.383232334778;30918;30933.535996960512;55529;55995.72002139963;56171;56311;56325;378800;393311;395031;395461;395742;28723.425531488836;33336.99989000334;33448.1637959053;34098.31803363968;34521.82739086389;44509.88725281894;44978.55021449744;45821.77089114533;45842.541574585164;45961.540384595726;35414.64585354114;36363.45454818233;36579.451308229865;36729.63270367369;37693;35467;35992.820035899655;36136;36758.63241367552;36981.260374792895;36977;37131.628683712814;38587;39025.41461878131;39355.6064439352;30389.848050759603;31955.520667190474;32320.86876959295;32485.18787030343;32504.34991300208;20085.899570502053;24354.63468048016;24903.875480622482;25156.622650659887;25239.49521009606 04:27:10 INFO - PROCESS | 1663 | |2;jquery.html;289.77831958551707;357.5816294934926;359.59820101836624;361.095455883013;368.0485943835186;15075.321610527526;15592.84407155928;18995;19297.710534341997;19386;18809.905950470227;19136.712949305736;19646.90176549115;20141.59716805663;20168.59662806743;5489.752961116759;5746.252987111669;5820.010598198316;5947.078202878561;5968.224130862982;3620.3664358737246;5614.9438505615035;5781.364049954502;5830.44610761979;5830.912536311958;5879.088741245092;5885.676287804169;5890.263717035371;5892.911606325909;5893.675847828367;5664.376918538957;5866.70666466675;5867.207926929874;6367.681615919186;6374.968125159391;5578.748956296977;5596.188552659883;5598.972005139948;5599.160125981095;5605.047141985831;12932.612021639367;18255.72616410755;24228;25176.748232517806;25186.49627007468;1838.6690395728763;2010.447127040061;2072.720182775321;2721.79586531009;2726.7954903382324;9597.337704463416;10306.33008854422;10312.381257124522;10329.948350258275;12035.023974744558;1597.3427197461772;1694.1783235130952;1706.8037175724703;1717.6221231329087;1765.48800847754;84570.28028133085;102637.46043809349;103572.99999999924;103898;104054;8324.70863519774;10926.016658500774;10930.890691093146;11000.779984400267;11023.889761102286;12006.21959572625;12448.502059917502;13568.660783480294;13632.386542605409;13635.863641363658;7982.361411087099;8253.380996425292;8386.412951093365;8411.663533458715;8414.621342039623;6854.34883686049;8393.370497212734;8399.992000959925;8472.364572656952;8511.489310641258;4213.6839737019845;4284.228838809045;4291.141771645684;4335.544767799399;4338.284183109751;1583.4299652125226;1788.4724006417878;1863.413024897153;1874.681304178293;1879.7838248601586;919.3932004876749;966.7244835221928;970.8737864077625;1013.9087482126644;1030.9793804123876;19117.426477205707;19645.607087858163;19742.40772776819;19818.60362792736;19905.402837914884;752.785456144996;892.607252808762;945.6737425588161;973.1290495006929;977.1498796047484;9911.355761875455;9941.602335906628;9979.900200997898;10497.2127090467;11108.722281942855;571455;583782;592558;597094;604894;98547;112782.43608782068;115905.4204728971;119342;119787;1066.8506409102731;1087.2823936202226;1095.5343978808974;1121.0863146535548;1122.4387806096952;17407.47777566675;17602.383916563373;17687.469375918743;18031.18859651345;18205.18076686526;47085.822854428916;48654.783630409525;48778;49150;49582.752086239336;62744;63587.682061589396;63805;63848;63977.72044559176;6451.516136289891;7441;7852.725154619561;7855.646495907584;8207.015158181057;11369.431528423711;12113.939430302793;12256.509739610316;12610.243385396905;12688.873111269138;9838.458884761407;10471.109955653856;10672.199585031309;10744.946275268574;10905.890941090487;9664.75838104053;10026.197904167795;10623.150147988297;10784.029437350677;10995.34027958325;10732.73168170802;11086.113110951266;11151.386673732699;11178.217524773188;11535.480903359537;7744;7857.174996625272;7989.680412783424;8056.476329038594;8208.220219079178;10032.498375081072;10890.564377424815;10975.670729878117;11309.943450282695;11342.092632589538 04:27:10 INFO - PROCESS | 1663 | |3;mootools.html;1447.377627620123;1575.3698520591765;1601.8077830660322;1856.1276200185907;1988.9104990275437;7963.24349186827;8470.576471176448;8739.737807865758;8761.780955476117;8780.604872780725;8430.578471076436;8675.132486751338;8678.739637810875;8679.522626255553;8701.825963480742;2164.935051948436;2396.341006223294;2446.645236440715;2471.060996821205;2490.3898544856534;2482.9255122346267;2491.6137998610243;2494.5260400523935;2497.1010436243027;2497.687789026372;2395.988020059906;2451.9387015324583;2480.578301688717;2481.9751802482015;2483.3543278747475;2436.9390765230833;2454.263720883737;2459.606462965926;2477.9752202478103;2478.2689106713565;2420.455397535558;2442.78014978651;2445.5475736988537;2463.88912498938;2479.3181874984525;8707.956460217658;8818.735437936872;8820.2061814437;8830.602622881986;8850.026497085315;5398.2982212312145;5567.49892509672;5574.247476590649;5575.609707320448;5577.135543990688;3505.5618047744033;3598.5501812273465;3668.5781135169264;3698.4637227601847;3709.462127991453;1055.6305293147414;1060.6128763001525;1070.9143268538498;1077.6282182646974;1079.2337440417314;11880.346580938045;11884.40577971098;11890.702732431759;11898.46456909441;11898.940505297505;4843.564079232886;4856.80572777092;4940.925886111711;4967.428745694219;4974.527419895104;10192.439415832201;10198.439085850201;10207.183425326104;10213.927537608593;10226.437545934896;5526.530244929226;5545.140503222007;5546.611737178358;5551.111822108443;5566.441396409012;4417.249067658506;4583.495815460296;4796;4964.975175124101;4999.775010124553;3814.7901865397116;3911.6870650347905;3919.6472317490993;3946.427767973628;3980.542237642708;1304.178367628388;1305.8367704036996;1317.6574090736285;1323.93380330985;1326.4163767942075;1156.2657712352548;1174.770919670673;1178.0810967445407;1366.152985149214;1385.4181243877595;8001.919980800234;8241.25828675422;8244.54654993981;8245.340372770164;8254.05078415978;515.3043391421551;521.455079441984;527.4751622135923;530.8142150247382;533.168257518265;6163.19878415812;6227;6288.8427789304715;6307.400796924285;6319.431251187415;10290.536925838354;10556.366618002945;10676.199285053652;10678.252522323519;10753.408562529135;10393.896061039444;10481.423521706227;10532.15742740579;10574.154067674568;10609.522571484147;8179.877301840358;8278.089410164877;8300.70947516822;8345.123762005023;8367.581620918929;7662.080550333995;7900;7904.84190316179;7917.841643166989;7964.442489025712;9249.537523123683;9532.759801446517;9551.42691438516;9626.374285671409;9698.806023879624;9673.806523869624;9834.508274586386;9850.014998500093;9867.457289849128;9983.60065597368;6709.698063587248;6835.726570937107;7343.632818358954;7437.070366204224;7529.058867641545;8178.427510074238;8200.343972482067;8254.174582541698;8260.132686067876;8262.586870656563;7230.927690723025;7271.854562908818;7324.450666200163;7478.214787447458;7486.326230639269;7094.964525177547;7180.281971802778;7247.818804529929;7269.927300726925;7298.343149116605;7218;7667.501612395176;7668.539887606538;7681;7684.9231507686445;6885.724571017103;6894.207166175954;6967.407770339375;6976.720931162697;6985;6947.096877405905;7017;7025.543339682904;7033.577985320897;7034.1910680270375 04:27:10 INFO - PROCESS | 1663 | |4;prototype.html;288.71273083282136;323.37427078602906;324.3771957840945;331.4531023810713;335.6425406941606;5396.244525766396;6412.711427985741;6667.599944003357;6694.230163531195;6703.396694297512;6458.451031662303;6605;6609.933900660992;6615.768448104317;6652.168478940132;4660.790264438108;4725.55107264811;4806.4232292125;4832.951670483285;4890.437599676038;4339.023719663066;4731.290306454025;4805.3753012108555;4842.467328593852;4863.051704917542;4807.326974223612;4811.615070794328;4817.301491283762;4843.273508973647;4844.951550484503;3962.643362097425;4072.572379900127;4440.755758433284;4833.975830120862;4851.805927762921;3352.2960178362573;4062.1469491406842;4082.4692789937417;4086.734362266473;4101.8974525636795;6320.81037568869;6323.33604971476;6338.271098823649;6349.492040636738;6370.681465926685;5599.160125981095;5631.971840140773;5636.408177141382;5642.689652069134;5659.490645841894;7011.824704382431;7012.544184628034;7035.437165026786;7038.366547010743;7048.400885924702;4536.56902594253;4552.180607490651;4685.929711054337;4729.4797572267025;4736.5026672199265;7206.639668016578;7238.2761723827725;7279.563226206445;7287.05268315121;7314.7439839605895;4828.444728856156;4834.380482538389;4834.830780922721;4838.395200599925;4841.273808928619;4882.780274887638;4889.4377146627885;4897.118518666674;4907.754612269444;4909.337239472626;5796.710164491758;5802.506786923074;5811.941880581225;5817.680027598438;5823.242978412779;5758.7696492140685;6748.696308666122;6995.650217489105;7077;7102.92897071033;1688.4512533426685;1692.5768557860536;1699.4731633193749;1708.7607734917121;1712.2808420463434;1104.3263609198382;1105.789899919013;1130.5138790320077;1132.7111586545377;1135.812590922505;5766.452187042224;6204.255489341218;6421.678916054178;6616.669166541654;6660;7367.373773229336;7370.115586129698;7373.88939165913;7374.262573742582;7382.5570465772225;6604.504662150358;6615.6030638161865;6621.5364924454825;6625.238097618739;6631.767888123893;3814.122751767109;3857.864974725871;3866.8066596670055;3873.6320049595242;3878.612138786099;7347.33873951347;7625.428092893055;7631.007968963999;7661.731839385706;7666.233376662401;5714.885702286014;7522.435817313723;7537.472376933562;7544.698212071456;7548.396128309722;6566.244881838458;7625.199354067743;7633.160352361347;7648.273414025659;7650.081990161217;5614.5789065821045;7153.785386438415;7314.743983960536;7318.1949985502615;7343.963280183565;6897.7585784497305;7211.927880721126;7228.168760592599;7233.891491627524;7281.01706269668;7597.392208623407;7645.961770191336;7652.617369131633;7657.889606007209;7680.116786569616;4584.587387135174;4638.582527572535;4649.418822647169;4653.1391692535635;4683.367745354333;7303.707851685873;7304.63476826146;7305.671244793891;7309.086364204474;7332.853342933218;6744.494162937701;7053.576785392893;7066.152061752623;7072.328128827753;7099;5727.914081288867;6997.755078572225;7032.964835175791;7041.225465198721;7077.6461176941975;5650.745716442688;6898.482333886537;6900.689468973807;6910.343517365842;6922.411595014279;6766.594004359754;7068.328508791862;7072.858542829217;7074.752383666547;7090.688222678821;6627.801165965029;6702.463802895854;6872.931270687229;6889.104416425833;6889.862202756017 04:27:10 INFO - PROCESS | 1663 | |5;yui.html;702.5152644675173;735.2353552305602;750.7544833963935;765.6860687118283;774.7443343696581;14967.802575793938;15108.697826043472;15155.848441515582;15205.847941520582;15224.086554806705;13846.584602461942;14068.366923488442;14217.360218790154;14242.931780116482;14256.643583910407;747.7719295614835;759.6429678051308;903.7469508537604;927.2952556057411;927.378656300277;926.9536523173848;935.672514619881;935.7333160049387;935.9391639543408;938.4556956964979;967.6371360739722;970.1026550440849;975.9560819763092;976.6630512473185;979.6571200079951;771.6411868481155;960.8991055939096;964.2189826240767;982.2338575910801;987.5407935310044;703.8310805406717;725.2022774947568;734.9338559529668;741.6921977379435;744.7951813251399;14905.03117297383;14964.551063468005;14987.925060374737;15012.924935375362;15048.247587620575;12345.074119441078;12367.257964522158;12377;12385.690357741038;12723.918466930321;9895.455749933752;10061.396316220977;10070.446125463097;10117.241206909512;10626.990435908576;3433.4163192257374;3504.386732321859;3545.804980726059;3620.456931460276;3761.9435708464393;60544.091838622895;73707.89438158432;74211;75767.62116189439;75959.86060209101;9405.623775049058;9417.529123543796;9441.90558094424;9654.806903862023;9758.853617195748;21039.368818935458;21909;21958.121675133134;21960.121595136017;21963.670544941837;7390.704371825067;7471.252874712594;7551.207123252089;7595.050618672666;7806.765797026098;3559.341521818472;4058.0869304406865;4093.3655283431117;4126.8761937141935;4251.915761480803;3575.713942884563;3635.381985062546;3635.9091022724115;3645.908852278661;3649.525561676965;578.9363170051291;651.6481100205931;666.3136968922018;674.2515807453723;688.703857341338;554.8585110796721;557.8075563930438;599.868029033612;600.5945986459122;610.6003406612057;7748.690052397841;7920.445568810128;7981.680732770624;8078.636461359253;8216.671333146727;579.1370857422495;601.4556826072411;603.6016229288648;604.8699529601068;614.5176036811082;3666.175110600147;3864.246471937945;3908.7459315144424;3910.335243008695;3922.1175235572337;85593;87747.56126219328;87828.12171878327;88034.55982720046;88035;73799.63100184572;74066.14834629069;74741.62629186819;76304.61847690726;76875;66760.66619666967;67237.6638116816;67814.98277525841;68365.43386693338;69299.30700693029;7855.175206603453;7855.450118491651;7875.094364148196;7881.921180788118;7905.644246008828;48575.27137093017;49292.50707492879;49613.50386496089;49718.751406242736;50003.749981249865;62088;63228;63877.6806115985;64572;67882;10791.892081079088;10862.511186996762;11087.168462365516;11089.112870970464;11271.436428178722;11733.882661173278;11753.647390578297;11781.175317727677;11939.940300298444;12109.878901210875;11155.05182059534;11236.583575149341;11254.072230010566;11500.94249528747;12239.87760122423;10204.744881378025;10727.249092563447;11453.656390308304;11477.426128693698;11650.941745291218;9159.771005724644;11219.943900280447;11395.700577719437;11454.713632159262;11577.247478913843;8130.715424960098;9466.195373393339;9603.087706667855;9614.95192524033;9695.854562181714;9068.455892646462;9618.470984095942;9673.661421850484;9697;9877.50612469388 04:27:10 INFO - PROCESS | 1663 | __end_tp_report 04:27:10 INFO - PROCESS | 1663 | __start_cc_report 04:27:10 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,2183 04:27:10 INFO - PROCESS | 1663 | __end_cc_report 04:27:10 INFO - PROCESS | 1663 | __startTimestamp1459855630073__endTimestamp 04:27:10 INFO - PROCESS | 1663 | 04:27:10 INFO - PROCESS | 1663 | ------- Summary: start ------- 04:27:10 INFO - PROCESS | 1663 | Number of tests: 6 04:27:10 INFO - PROCESS | 1663 | 04:27:10 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5723.22 Median:5942.82 stddev:651.72 (11.0%) stddev-sans-first:628.10 04:27:10 INFO - PROCESS | 1663 | Values: 3416.7 3462.1 3500.0 3502.7 3525.6 5380.9 5637.0 5678.8 5714.6 5722.7 4629.3 5734.8 5734.9 5799.3 5837.9 4276.5 5142.8 5153.5 5157.2 5310.0 5286.3 5317.0 5337.4 5337.9 5377.1 5151.2 5162.7 5264.1 5267.2 5300.9 4277.2 5264.8 5268.2 5315.0 5327.3 5163.7 5220.7 5233.1 5264.4 5271.7 5552.1 5644.5 5670.7 5673.2 5679.5 6138.0 6249.3 6252.4 6257.0 6278.3 6261.2 6284.2 6308.4 6313.7 6333.9 5701.9 5716.2 5822.8 5833.2 5835.1 6229.4 6285.3 6293.3 6295.6 6307.1 6093.8 6182.8 6183.9 6187.9 6205.0 6069.5 6132.7 6269.1 6278.2 6284.3 6159.5 6181.3 6199.5 6205.1 6212.9 6165.9 6230.6 6233.3 6234.3 6236.9 4817.2 4844.8 4883.9 4890.3 4927.3 4378.5 4391.7 4409.9 4420.8 4461.1 5598.3 5639.4 5643.1 5650.1 5670.5 6138.5 6179.8 6201.4 6268.0 6290.3 5596.2 5621.7 5628.9 5631.4 5642.6 5303.6 5310.3 5312.1 5314.7 5356.3 6180.7 6211.6 6216.1 6252.5 6258.5 6287.4 6297.5 6298.1 6306.0 6322.7 6239.5 6279.3 6281.2 6297.6 6310.0 5968.6 6141.9 6177.4 6209.9 6220.8 6251.4 6289.5 6290.2 6292.0 6303.1 5942.8 6117.4 6147.7 6155.5 6182.6 5991.8 6082.3 6110.8 6116.9 6117.8 5916.4 5924.9 5931.7 5946.9 5956.2 6062.3 6079.5 6098.5 6109.9 6123.4 4874.9 5913.4 5927.0 5931.3 6075.1 04:27:10 INFO - PROCESS | 1663 | 04:27:10 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:59909.25 Median:38721.52 stddev:120351.41 (310.8%) stddev-sans-first:120606.38 04:27:10 INFO - PROCESS | 1663 | Values: 501.6 545.4 584.6 637.6 642.0 38060.6 38398.2 38594.6 38596.8 38600.2 40083.0 40580.0 40588.4 40678.0 40775.0 9224.4 9477.7 9480.5 9481.7 9484.9 9482.0 9653.0 9671.2 9675.2 9703.0 9582.0 9655.6 9666.2 9671.3 9676.8 9459.8 9498.4 9545.6 9637.0 9640.8 9472.0 9627.3 9636.0 9651.7 9662.6 38842.8 39211.0 39340.8 39394.6 39421.0 3228.6 3422.3 3580.9 3847.1 4136.9 28715.1 28799.7 28919.7 29307.9 29672.6 2759.1 2760.0 2760.0 2844.2 2887.6 477396.0 477651.0 478773.0 479854.0 481008.6 46609.5 69563.7 70088.0 70208.6 70245.0 45852.8 46112.8 46169.3 46259.8 46320.8 15534.6 15964.9 15969.8 15981.5 16011.7 12593.6 12667.9 12674.9 12771.2 12773.0 15015.5 15055.9 15079.8 15110.9 15233.1 6211.4 6334.2 6379.8 6396.5 6401.3 920.2 975.0 1009.9 1060.7 1089.3 23944.3 29063.0 29517.0 29734.7 29945.7 1039.7 1098.0 1145.8 1174.5 1245.0 14899.6 15019.8 15035.4 15349.8 15371.5 480904.0 483520.0 484437.0 484766.0 486188.0 58553.0 59959.7 60181.7 60211.1 60260.7 1329.7 1342.3 1395.2 1428.5 1474.4 28588.4 29879.0 30838.4 30918.0 30933.5 55529.0 55995.7 56171.0 56311.0 56325.0 378800.0 393311.0 395031.0 395461.0 395742.0 28723.4 33337.0 33448.2 34098.3 34521.8 44509.9 44978.6 45821.8 45842.5 45961.5 35414.6 36363.5 36579.5 36729.6 37693.0 35467.0 35992.8 36136.0 36758.6 36981.3 36977.0 37131.6 38587.0 39025.4 39355.6 30389.8 31955.5 32320.9 32485.2 32504.3 20085.9 24354.6 24903.9 25156.6 25239.5 04:27:10 INFO - PROCESS | 1663 | 04:27:10 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:32904.08 Median:13954.15 stddev:97733.17 (700.4%) stddev-sans-first:97976.66 04:27:10 INFO - PROCESS | 1663 | Values: 289.8 357.6 359.6 361.1 368.0 15075.3 15592.8 18995.0 19297.7 19386.0 18809.9 19136.7 19646.9 20141.6 20168.6 5489.8 5746.3 5820.0 5947.1 5968.2 3620.4 5614.9 5781.4 5830.4 5830.9 5879.1 5885.7 5890.3 5892.9 5893.7 5664.4 5866.7 5867.2 6367.7 6375.0 5578.7 5596.2 5599.0 5599.2 5605.0 12932.6 18255.7 24228.0 25176.7 25186.5 1838.7 2010.4 2072.7 2721.8 2726.8 9597.3 10306.3 10312.4 10329.9 12035.0 1597.3 1694.2 1706.8 1717.6 1765.5 84570.3 102637.5 103573.0 103898.0 104054.0 8324.7 10926.0 10930.9 11000.8 11023.9 12006.2 12448.5 13568.7 13632.4 13635.9 7982.4 8253.4 8386.4 8411.7 8414.6 6854.3 8393.4 8400.0 8472.4 8511.5 4213.7 4284.2 4291.1 4335.5 4338.3 1583.4 1788.5 1863.4 1874.7 1879.8 919.4 966.7 970.9 1013.9 1031.0 19117.4 19645.6 19742.4 19818.6 19905.4 752.8 892.6 945.7 973.1 977.1 9911.4 9941.6 9979.9 10497.2 11108.7 571455.0 583782.0 592558.0 597094.0 604894.0 98547.0 112782.4 115905.4 119342.0 119787.0 1066.9 1087.3 1095.5 1121.1 1122.4 17407.5 17602.4 17687.5 18031.2 18205.2 47085.8 48654.8 48778.0 49150.0 49582.8 62744.0 63587.7 63805.0 63848.0 63977.7 6451.5 7441.0 7852.7 7855.6 8207.0 11369.4 12113.9 12256.5 12610.2 12688.9 9838.5 10471.1 10672.2 10744.9 10905.9 9664.8 10026.2 10623.2 10784.0 10995.3 10732.7 11086.1 11151.4 11178.2 11535.5 7744.0 7857.2 7989.7 8056.5 8208.2 10032.5 10890.6 10975.7 11309.9 11342.1 04:27:10 INFO - PROCESS | 1663 | 04:27:10 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:6031.12 Median:5462.41 stddev:3188.61 (58.4%) stddev-sans-first:3178.94 04:27:10 INFO - PROCESS | 1663 | Values: 1447.4 1575.4 1601.8 1856.1 1988.9 7963.2 8470.6 8739.7 8761.8 8780.6 8430.6 8675.1 8678.7 8679.5 8701.8 2164.9 2396.3 2446.6 2471.1 2490.4 2482.9 2491.6 2494.5 2497.1 2497.7 2396.0 2451.9 2480.6 2482.0 2483.4 2436.9 2454.3 2459.6 2478.0 2478.3 2420.5 2442.8 2445.5 2463.9 2479.3 8708.0 8818.7 8820.2 8830.6 8850.0 5398.3 5567.5 5574.2 5575.6 5577.1 3505.6 3598.6 3668.6 3698.5 3709.5 1055.6 1060.6 1070.9 1077.6 1079.2 11880.3 11884.4 11890.7 11898.5 11898.9 4843.6 4856.8 4940.9 4967.4 4974.5 10192.4 10198.4 10207.2 10213.9 10226.4 5526.5 5545.1 5546.6 5551.1 5566.4 4417.2 4583.5 4796.0 4965.0 4999.8 3814.8 3911.7 3919.6 3946.4 3980.5 1304.2 1305.8 1317.7 1323.9 1326.4 1156.3 1174.8 1178.1 1366.2 1385.4 8001.9 8241.3 8244.5 8245.3 8254.1 515.3 521.5 527.5 530.8 533.2 6163.2 6227.0 6288.8 6307.4 6319.4 10290.5 10556.4 10676.2 10678.3 10753.4 10393.9 10481.4 10532.2 10574.2 10609.5 8179.9 8278.1 8300.7 8345.1 8367.6 7662.1 7900.0 7904.8 7917.8 7964.4 9249.5 9532.8 9551.4 9626.4 9698.8 9673.8 9834.5 9850.0 9867.5 9983.6 6709.7 6835.7 7343.6 7437.1 7529.1 8178.4 8200.3 8254.2 8260.1 8262.6 7230.9 7271.9 7324.5 7478.2 7486.3 7095.0 7180.3 7247.8 7269.9 7298.3 7218.0 7667.5 7668.5 7681.0 7684.9 6885.7 6894.2 6967.4 6976.7 6985.0 6947.1 7017.0 7025.5 7033.6 7034.2 04:27:10 INFO - PROCESS | 1663 | 04:27:10 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:5731.56 Median:6512.35 stddev:1825.96 (28.0%) stddev-sans-first:1784.80 04:27:10 INFO - PROCESS | 1663 | Values: 288.7 323.4 324.4 331.5 335.6 5396.2 6412.7 6667.6 6694.2 6703.4 6458.5 6605.0 6609.9 6615.8 6652.2 4660.8 4725.6 4806.4 4833.0 4890.4 4339.0 4731.3 4805.4 4842.5 4863.1 4807.3 4811.6 4817.3 4843.3 4845.0 3962.6 4072.6 4440.8 4834.0 4851.8 3352.3 4062.1 4082.5 4086.7 4101.9 6320.8 6323.3 6338.3 6349.5 6370.7 5599.2 5632.0 5636.4 5642.7 5659.5 7011.8 7012.5 7035.4 7038.4 7048.4 4536.6 4552.2 4685.9 4729.5 4736.5 7206.6 7238.3 7279.6 7287.1 7314.7 4828.4 4834.4 4834.8 4838.4 4841.3 4882.8 4889.4 4897.1 4907.8 4909.3 5796.7 5802.5 5811.9 5817.7 5823.2 5758.8 6748.7 6995.7 7077.0 7102.9 1688.5 1692.6 1699.5 1708.8 1712.3 1104.3 1105.8 1130.5 1132.7 1135.8 5766.5 6204.3 6421.7 6616.7 6660.0 7367.4 7370.1 7373.9 7374.3 7382.6 6604.5 6615.6 6621.5 6625.2 6631.8 3814.1 3857.9 3866.8 3873.6 3878.6 7347.3 7625.4 7631.0 7661.7 7666.2 5714.9 7522.4 7537.5 7544.7 7548.4 6566.2 7625.2 7633.2 7648.3 7650.1 5614.6 7153.8 7314.7 7318.2 7344.0 6897.8 7211.9 7228.2 7233.9 7281.0 7597.4 7646.0 7652.6 7657.9 7680.1 4584.6 4638.6 4649.4 4653.1 4683.4 7303.7 7304.6 7305.7 7309.1 7332.9 6744.5 7053.6 7066.2 7072.3 7099.0 5727.9 6997.8 7033.0 7041.2 7077.6 5650.7 6898.5 6900.7 6910.3 6922.4 6766.6 7068.3 7072.9 7074.8 7090.7 6627.8 6702.5 6872.9 6889.1 6889.9 04:27:10 INFO - PROCESS | 1663 | 04:27:10 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:17646.43 Median:62658.00 stddev:24247.10 (38.7%) stddev-sans-first:24281.74 04:27:10 INFO - PROCESS | 1663 | Values: 702.5 735.2 750.8 765.7 774.7 14967.8 15108.7 15155.8 15205.8 15224.1 13846.6 14068.4 14217.4 14242.9 14256.6 747.8 759.6 903.7 927.3 927.4 927.0 935.7 935.7 935.9 938.5 967.6 970.1 976.0 976.7 979.7 771.6 960.9 964.2 982.2 987.5 703.8 725.2 734.9 741.7 744.8 14905.0 14964.6 14987.9 15012.9 15048.2 12345.1 12367.3 12377.0 12385.7 12723.9 9895.5 10061.4 10070.4 10117.2 10627.0 3433.4 3504.4 3545.8 3620.5 3761.9 60544.1 73707.9 74211.0 75767.6 75959.9 9405.6 9417.5 9441.9 9654.8 9758.9 21039.4 21909.0 21958.1 21960.1 21963.7 7390.7 7471.3 7551.2 7595.1 7806.8 3559.3 4058.1 4093.4 4126.9 4251.9 3575.7 3635.4 3635.9 3645.9 3649.5 578.9 651.6 666.3 674.3 688.7 554.9 557.8 599.9 600.6 610.6 7748.7 7920.4 7981.7 8078.6 8216.7 579.1 601.5 603.6 604.9 614.5 3666.2 3864.2 3908.7 3910.3 3922.1 85593.0 87747.6 87828.1 88034.6 88035.0 73799.6 74066.1 74741.6 76304.6 76875.0 66760.7 67237.7 67815.0 68365.4 69299.3 7855.2 7855.5 7875.1 7881.9 7905.6 48575.3 49292.5 49613.5 49718.8 50003.7 62088.0 63228.0 63877.7 64572.0 67882.0 10791.9 10862.5 11087.2 11089.1 11271.4 11733.9 11753.6 11781.2 11939.9 12109.9 11155.1 11236.6 11254.1 11500.9 12239.9 10204.7 10727.2 11453.7 11477.4 11650.9 9159.8 11219.9 11395.7 11454.7 11577.2 8130.7 9466.2 9603.1 9615.0 9695.9 9068.5 9618.5 9673.7 9697.0 9877.5 04:27:10 INFO - PROCESS | 1663 | -------- Summary: end -------- 04:27:10 INFO - PROCESS | 1663 | 04:27:10 INFO - TEST-INFO | 1663: exit 0 04:27:10 INFO - TEST-OK | dromaeo_css | took 1113293ms 04:27:10 INFO - TEST-START | kraken 04:27:10 INFO - operating with platform_type : mac_ 04:27:10 INFO - Initialising browser for kraken test... 04:27:10 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpL5SsBa/profile http://localhost:49275/getInfo.html) 04:27:12 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 04:27:12 INFO - PROCESS | 1673 | colorDepth:24 04:27:12 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 04:27:12 INFO - PROCESS | 1673 | __metrics 04:27:12 INFO - PROCESS | 1673 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:27:12 ERROR - PROCESS | 1673 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:27:13 INFO - TEST-INFO | 1673: exit 0 04:27:13 INFO - Browser initialized. 04:27:13 INFO - Running cycle 1/1 for kraken test... 04:27:13 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpL5SsBa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:27:25 INFO - PROCESS | 1675 | RSS: Main: 235872256 04:27:25 INFO - PROCESS | 1675 | 04:27:27 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 04:27:28 INFO - PROCESS | 1675 | RSS: Main: 282828800 04:27:28 INFO - PROCESS | 1675 | 04:27:30 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 04:27:31 INFO - PROCESS | 1675 | RSS: Main: 293015552 04:27:31 INFO - PROCESS | 1675 | 04:27:34 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 04:27:35 INFO - PROCESS | 1675 | RSS: Main: 281300992 04:27:35 INFO - PROCESS | 1675 | 04:27:37 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 04:27:37 INFO - PROCESS | 1675 | RSS: Main: 283328512 04:27:37 INFO - PROCESS | 1675 | 04:27:40 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:27:40 INFO - PROCESS | 1675 | RSS: Main: 284397568 04:27:40 INFO - PROCESS | 1675 | 04:27:43 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 04:27:43 INFO - PROCESS | 1675 | RSS: Main: 284311552 04:27:43 INFO - PROCESS | 1675 | 04:27:46 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 04:27:47 INFO - PROCESS | 1675 | RSS: Main: 284401664 04:27:47 INFO - PROCESS | 1675 | 04:27:50 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 04:27:50 INFO - PROCESS | 1675 | RSS: Main: 284766208 04:27:50 INFO - PROCESS | 1675 | 04:27:52 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:27:52 INFO - PROCESS | 1675 | RSS: Main: 315387904 04:27:52 INFO - PROCESS | 1675 | 04:27:54 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:27:55 INFO - PROCESS | 1675 | RSS: Main: 316063744 04:27:55 INFO - PROCESS | 1675 | 04:27:57 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:27:58 INFO - PROCESS | 1675 | RSS: Main: 322994176 04:27:58 INFO - PROCESS | 1675 | 04:28:00 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:28:01 INFO - PROCESS | 1675 | RSS: Main: 324358144 04:28:01 INFO - PROCESS | 1675 | 04:28:03 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:28:04 INFO - PROCESS | 1675 | RSS: Main: 324354048 04:28:04 INFO - PROCESS | 1675 | 04:28:06 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 04:28:06 INFO - PROCESS | 1675 | RSS: Main: 387080192 04:28:06 INFO - PROCESS | 1675 | 04:28:06 INFO - PROCESS | 1675 | __start_tp_report 04:28:06 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 04:28:06 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 04:28:06 INFO - PROCESS | 1675 | |i|pagename|runs| 04:28:06 INFO - PROCESS | 1675 | |0;ai-astar;112;108;111;111;112;114;117;113;111;109 04:28:06 INFO - PROCESS | 1675 | |1;audio-beat-detection;167;140;184;154;119;142;141;118;160;119 04:28:06 INFO - PROCESS | 1675 | |2;audio-dft;183;184;187;184;184;185;185;180;183;183 04:28:06 INFO - PROCESS | 1675 | |3;audio-fft;73;79;74;116;54;57;56;59;118;56 04:28:06 INFO - PROCESS | 1675 | |4;audio-oscillator;91;93;127;78;79;80;119;80;78;116 04:28:06 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;90;86;91;88;90;87;90;88;90;86 04:28:06 INFO - PROCESS | 1675 | |6;imaging-darkroom;94;94;95;95;94;95;95;96;94;94 04:28:06 INFO - PROCESS | 1675 | |7;imaging-desaturate;88;88;85;86;87;87;86;88;86;84 04:28:06 INFO - PROCESS | 1675 | |8;json-parse-financial;55;56;53;54;54;53;54;65;55;53 04:28:06 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;63;63;74;75;71;67;67;67;67;68 04:28:06 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;85;84;99;109;110;83;81;83;85;84 04:28:06 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;142;131;132;134;119;119;120;119;126;135 04:28:06 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;146;128;140;123;148;175;142;138;133;138 04:28:06 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;65;69;69;67;68;67;66;67;65;68 04:28:06 INFO - PROCESS | 1675 | __end_tp_report 04:28:06 INFO - PROCESS | 1675 | __start_cc_report 04:28:06 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1316 04:28:06 INFO - PROCESS | 1675 | __end_cc_report 04:28:06 INFO - PROCESS | 1675 | __startTimestamp1459855686331__endTimestamp 04:28:06 INFO - PROCESS | 1675 | 04:28:06 INFO - PROCESS | 1675 | ------- Summary: start ------- 04:28:06 INFO - PROCESS | 1675 | Number of tests: 14 04:28:06 INFO - PROCESS | 1675 | 04:28:06 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:2.53 (2.3%) stddev-sans-first:2.68 04:28:06 INFO - PROCESS | 1675 | Values: 112.0 108.0 111.0 111.0 112.0 114.0 117.0 113.0 111.0 109.0 04:28:06 INFO - PROCESS | 1675 | 04:28:06 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:148.00 stddev:22.21 (15.0%) stddev-sans-first:22.00 04:28:06 INFO - PROCESS | 1675 | Values: 167.0 140.0 184.0 154.0 119.0 142.0 141.0 118.0 160.0 119.0 04:28:06 INFO - PROCESS | 1675 | 04:28:06 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:1.81 (1.0%) stddev-sans-first:1.90 04:28:06 INFO - PROCESS | 1675 | Values: 183.0 184.0 187.0 184.0 184.0 185.0 185.0 180.0 183.0 183.0 04:28:06 INFO - PROCESS | 1675 | 04:28:06 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:74.20 Median:58.00 stddev:24.24 (41.8%) stddev-sans-first:25.71 04:28:06 INFO - PROCESS | 1675 | Values: 73.0 79.0 74.0 116.0 54.0 57.0 56.0 59.0 118.0 56.0 04:28:06 INFO - PROCESS | 1675 | 04:28:06 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:79.50 stddev:19.26 (24.2%) stddev-sans-first:20.39 04:28:06 INFO - PROCESS | 1675 | Values: 91.0 93.0 127.0 78.0 79.0 80.0 119.0 80.0 78.0 116.0 04:28:06 INFO - PROCESS | 1675 | 04:28:06 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:88.60 Median:90.00 stddev:1.84 (2.0%) stddev-sans-first:1.88 04:28:06 INFO - PROCESS | 1675 | Values: 90.0 86.0 91.0 88.0 90.0 87.0 90.0 88.0 90.0 86.0 04:28:06 INFO - PROCESS | 1675 | 04:28:06 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 04:28:06 INFO - PROCESS | 1675 | Values: 94.0 94.0 95.0 95.0 94.0 95.0 95.0 96.0 94.0 94.0 04:28:06 INFO - PROCESS | 1675 | 04:28:06 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:86.50 Median:87.00 stddev:1.35 (1.6%) stddev-sans-first:1.32 04:28:06 INFO - PROCESS | 1675 | Values: 88.0 88.0 85.0 86.0 87.0 87.0 86.0 88.0 86.0 84.0 04:28:06 INFO - PROCESS | 1675 | 04:28:06 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:54.50 stddev:3.58 (6.6%) stddev-sans-first:3.80 04:28:06 INFO - PROCESS | 1675 | Values: 55.0 56.0 53.0 54.0 54.0 53.0 54.0 65.0 55.0 53.0 04:28:06 INFO - PROCESS | 1675 | 04:28:06 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:67.50 stddev:4.05 (6.0%) stddev-sans-first:3.83 04:28:06 INFO - PROCESS | 1675 | Values: 63.0 63.0 74.0 75.0 71.0 67.0 67.0 67.0 67.0 68.0 04:28:06 INFO - PROCESS | 1675 | 04:28:06 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:90.30 Median:84.00 stddev:11.26 (13.4%) stddev-sans-first:11.78 04:28:06 INFO - PROCESS | 1675 | Values: 85.0 84.0 99.0 109.0 110.0 83.0 81.0 83.0 85.0 84.0 04:28:06 INFO - PROCESS | 1675 | 04:28:06 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:131.50 stddev:8.27 (6.3%) stddev-sans-first:6.97 04:28:06 INFO - PROCESS | 1675 | Values: 142.0 131.0 132.0 134.0 119.0 119.0 120.0 119.0 126.0 135.0 04:28:06 INFO - PROCESS | 1675 | 04:28:06 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.10 Median:141.00 stddev:14.17 (10.0%) stddev-sans-first:14.92 04:28:06 INFO - PROCESS | 1675 | Values: 146.0 128.0 140.0 123.0 148.0 175.0 142.0 138.0 133.0 138.0 04:28:06 INFO - PROCESS | 1675 | 04:28:06 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.45 (2.1%) stddev-sans-first:1.32 04:28:06 INFO - PROCESS | 1675 | Values: 65.0 69.0 69.0 67.0 68.0 67.0 66.0 67.0 65.0 68.0 04:28:06 INFO - PROCESS | 1675 | -------- Summary: end -------- 04:28:06 INFO - PROCESS | 1675 | 04:28:06 INFO - TEST-INFO | 1675: exit 0 04:28:06 INFO - TEST-OK | kraken | took 56398ms 04:28:06 INFO - SUITE-END | took 1169s 04:28:06 INFO - Completed test suite (00:19:29) 04:28:06 INFO - javascript benchmark 04:28:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3416.6924976752093, 3462.0825481247475, 3499.9650003499964, 3502.719782417407, 3525.6298088700687, 5380.865478363033, 5636.957162924851, 5678.772849086036, 5714.599978001536, 5722.713864306778, 4629.259318509039, 5734.770609175638, 5734.913976290349, 5799.304083509975, 5837.9124313135335, 4276.486821581399, 5142.768575414116, 5153.510416510426, 5157.174852023677, 5310.0, 5286.3392075990505, 5316.9734151329185, 5337.359516857963, 5337.919931201035, 5377.139657654776, 5151.227315902607, 5162.716050617233, 5264.131418315973, 5267.1835865440535, 5300.920486192691, 4277.230098582254, 5264.842054738364, 5268.209768534713, 5315.01672190646, 5327.254184414185, 5163.66436181647, 5220.712860792655, 5233.136532472137, 5264.394594621629, 5271.65734227274, 5552.111662134039, 5644.491995720405, 5670.659760414388, 5673.234113394721, 5679.545636349082, 6137.969310153465, 6249.250089989185, 6252.406021427957, 6256.968715156395, 6278.340774218687, 6261.186045814015, 6284.2458904931245, 6308.400701933355, 6313.747450102036, 6333.936660633381, 5701.857453563611, 5716.228309178291, 5822.796202132948, 5833.241678581757, 5835.095560188135, 6229.4393504584805, 6285.340039295899, 6293.30773614902, 6295.559310848288, 6307.117003619405, 6093.817185484442, 6182.752689892444, 6183.907241391383, 6187.907181392283, 6205.007198848162, 6069.514438844882, 6132.692058233643, 6269.12232287471, 6278.215223097113, 6284.277308109535, 6159.476444502178, 6181.320054793969, 6199.473044791243, 6205.069239614094, 6212.937870621236, 6165.938340616536, 6230.59501132425, 6233.283172435137, 6234.251889773256, 6236.908541005306, 4817.181079216542, 4844.806207751651, 4883.877903052452, 4890.266460031024, 4927.260910863328, 4378.452693413324, 4391.67062470316, 4409.889752756207, 4420.80106395213, 4461.063176732922, 5598.300212473441, 5639.407862174495, 5643.125315576092, 5650.124230744241, 5670.489655930986, 6138.539609529304, 6179.84550386244, 6201.410865967726, 6267.96866015667, 6290.308066112724, 5596.1605759136455, 5621.690807005572, 5628.943710562924, 5631.352394474606, 5642.633228840113, 5303.575713942875, 5310.283111779938, 5312.096943519611, 5314.707691077027, 5356.303680521507, 6180.721867516063, 6211.596246243979, 6216.098665693449, 6252.499800015897, 6258.499320054385, 6287.434130928238, 6297.464715499051, 6298.11826344303, 6306.0, 6322.652254126067, 6239.4696450800375, 6279.277883043508, 6281.152044473937, 6297.55917085818, 6310.0, 5968.582199246011, 6141.9385806143155, 6177.382261773966, 6209.875802484015, 6220.813375598739, 6251.437370636664, 6289.49684025286, 6290.182276304051, 6292.024736165901, 6303.149074874833, 5942.821715348547, 6117.357677443804, 6147.692615369124, 6155.4767844731905, 6182.629042257479, 5991.820245392645, 6082.330943596289, 6110.816675499742, 6116.938830611637, 6117.847053823512, 5916.437938395846, 5924.911126333022, 5931.703414829155, 5946.881062378641, 5956.166136740773, 6062.302835174011, 6079.544034197541, 6098.512119030555, 6109.877802444015, 6123.4488895999575, 4874.926876096791, 5913.379095194942, 5927.0, 5931.288245410578, 6075.149479072845], "unit": "score", "name": "dojo.html", "value": 5682.7587670786415}, {"lowerIsBetter": false, "replicates": [501.5536172806201, 545.3700975373445, 584.6024703201821, 637.646106410942, 641.9582727122737, 38060.61939380609, 38398.23203535927, 38594.614053859455, 38596.807015964914, 38600.22799544007, 40083.0, 40580.0, 40588.39117413241, 40678.0, 40775.0, 9224.354295199355, 9477.715668529921, 9480.525973701322, 9481.66814161501, 9484.90515094847, 9481.952590237039, 9652.95173524135, 9671.226301895831, 9675.177609903167, 9703.029697030275, 9582.0, 9655.565499552502, 9666.178374838148, 9671.323007389485, 9676.806463870718, 9459.763505912339, 9498.430094194371, 9545.570449329762, 9637.0, 9640.75898102546, 9472.0, 9627.277954153396, 9636.0, 9651.710448686481, 9662.613495460244, 38842.805785970886, 39211.0, 39340.803295983336, 39394.60605393938, 39421.014474638076, 3228.580284563015, 3422.3326451342, 3580.9283814323567, 3847.076701591598, 4136.937945930814, 28715.13854584366, 28799.712002880122, 28919.710802891914, 29307.85346073256, 29672.554911676343, 2759.11708253359, 2759.9586006209925, 2759.986200069007, 2844.1609725131134, 2887.63904511936, 477396.0, 477651.0, 478773.0, 479854.0, 481008.594957023, 46609.5339046612, 69563.65218173977, 70088.0, 70208.6489567559, 70245.0, 45852.77073614678, 46112.84717882013, 46169.30746038812, 46259.76870115628, 46320.7683961578, 15534.611634708997, 15964.92017539905, 15969.760453593206, 15981.520554383387, 16011.679766404606, 12593.622191334274, 12667.936660316824, 12674.873251267369, 12771.169873958162, 12772.978161747038, 15015.549533514011, 15055.924720376328, 15079.849201508065, 15110.924445377703, 15233.086014839146, 6211.409916057967, 6334.176557047646, 6379.767081521523, 6396.5202609804455, 6401.327860574573, 920.2362039507193, 974.9658761943298, 1009.8535712321819, 1060.6764936694228, 1089.2810744908322, 23944.28167154988, 29062.982795602053, 29517.042366265126, 29734.702652973192, 29945.70054299429, 1039.667306461925, 1097.9945100274447, 1145.7651181507938, 1174.4949671641277, 1244.9813252801216, 14899.553013409615, 15019.849801501845, 15035.398584056515, 15349.846501534841, 15371.538853834403, 480904.0, 483520.0, 484437.0, 484766.0, 486188.0, 58553.0, 59959.700201498716, 60181.69909150426, 60211.09683354753, 60260.69869650711, 1329.7207586406769, 1342.3355439057534, 1395.2465668538875, 1428.4643258777958, 1474.3733913086894, 28588.42823143567, 29879.0, 30838.383232334778, 30918.0, 30933.535996960512, 55529.0, 55995.72002139963, 56171.0, 56311.0, 56325.0, 378800.0, 393311.0, 395031.0, 395461.0, 395742.0, 28723.425531488836, 33336.99989000334, 33448.1637959053, 34098.31803363968, 34521.82739086389, 44509.88725281894, 44978.55021449744, 45821.77089114533, 45842.541574585164, 45961.540384595726, 35414.64585354114, 36363.45454818233, 36579.451308229865, 36729.63270367369, 37693.0, 35467.0, 35992.820035899655, 36136.0, 36758.63241367552, 36981.260374792895, 36977.0, 37131.628683712814, 38587.0, 39025.41461878131, 39355.6064439352, 30389.848050759603, 31955.520667190474, 32320.86876959295, 32485.18787030343, 32504.34991300208, 20085.899570502053, 24354.63468048016, 24903.875480622482, 25156.622650659887, 25239.49521009606], "unit": "score", "name": "ext.html", "value": 19279.680309791773}, {"lowerIsBetter": false, "replicates": [289.77831958551707, 357.5816294934926, 359.59820101836624, 361.095455883013, 368.0485943835186, 15075.321610527526, 15592.84407155928, 18995.0, 19297.710534341997, 19386.0, 18809.905950470227, 19136.712949305736, 19646.90176549115, 20141.59716805663, 20168.59662806743, 5489.752961116759, 5746.252987111669, 5820.010598198316, 5947.078202878561, 5968.224130862982, 3620.3664358737246, 5614.9438505615035, 5781.364049954502, 5830.44610761979, 5830.912536311958, 5879.088741245092, 5885.676287804169, 5890.263717035371, 5892.911606325909, 5893.675847828367, 5664.376918538957, 5866.70666466675, 5867.207926929874, 6367.681615919186, 6374.968125159391, 5578.748956296977, 5596.188552659883, 5598.972005139948, 5599.160125981095, 5605.047141985831, 12932.612021639367, 18255.72616410755, 24228.0, 25176.748232517806, 25186.49627007468, 1838.6690395728763, 2010.447127040061, 2072.720182775321, 2721.79586531009, 2726.7954903382324, 9597.337704463416, 10306.33008854422, 10312.381257124522, 10329.948350258275, 12035.023974744558, 1597.3427197461772, 1694.1783235130952, 1706.8037175724703, 1717.6221231329087, 1765.48800847754, 84570.28028133085, 102637.46043809349, 103572.99999999924, 103898.0, 104054.0, 8324.70863519774, 10926.016658500774, 10930.890691093146, 11000.779984400267, 11023.889761102286, 12006.21959572625, 12448.502059917502, 13568.660783480294, 13632.386542605409, 13635.863641363658, 7982.361411087099, 8253.380996425292, 8386.412951093365, 8411.663533458715, 8414.621342039623, 6854.34883686049, 8393.370497212734, 8399.992000959925, 8472.364572656952, 8511.489310641258, 4213.6839737019845, 4284.228838809045, 4291.141771645684, 4335.544767799399, 4338.284183109751, 1583.4299652125226, 1788.4724006417878, 1863.413024897153, 1874.681304178293, 1879.7838248601586, 919.3932004876749, 966.7244835221928, 970.8737864077625, 1013.9087482126644, 1030.9793804123876, 19117.426477205707, 19645.607087858163, 19742.40772776819, 19818.60362792736, 19905.402837914884, 752.785456144996, 892.607252808762, 945.6737425588161, 973.1290495006929, 977.1498796047484, 9911.355761875455, 9941.602335906628, 9979.900200997898, 10497.2127090467, 11108.722281942855, 571455.0, 583782.0, 592558.0, 597094.0, 604894.0, 98547.0, 112782.43608782068, 115905.4204728971, 119342.0, 119787.0, 1066.8506409102731, 1087.2823936202226, 1095.5343978808974, 1121.0863146535548, 1122.4387806096952, 17407.47777566675, 17602.383916563373, 17687.469375918743, 18031.18859651345, 18205.18076686526, 47085.822854428916, 48654.783630409525, 48778.0, 49150.0, 49582.752086239336, 62744.0, 63587.682061589396, 63805.0, 63848.0, 63977.72044559176, 6451.516136289891, 7441.0, 7852.725154619561, 7855.646495907584, 8207.015158181057, 11369.431528423711, 12113.939430302793, 12256.509739610316, 12610.243385396905, 12688.873111269138, 9838.458884761407, 10471.109955653856, 10672.199585031309, 10744.946275268574, 10905.890941090487, 9664.75838104053, 10026.197904167795, 10623.150147988297, 10784.029437350677, 10995.34027958325, 10732.73168170802, 11086.113110951266, 11151.386673732699, 11178.217524773188, 11535.480903359537, 7744.0, 7857.174996625272, 7989.680412783424, 8056.476329038594, 8208.220219079178, 10032.498375081072, 10890.564377424815, 10975.670729878117, 11309.943450282695, 11342.092632589538], "unit": "score", "name": "jquery.html", "value": 9089.069750538596}, {"lowerIsBetter": false, "replicates": [1447.377627620123, 1575.3698520591765, 1601.8077830660322, 1856.1276200185907, 1988.9104990275437, 7963.24349186827, 8470.576471176448, 8739.737807865758, 8761.780955476117, 8780.604872780725, 8430.578471076436, 8675.132486751338, 8678.739637810875, 8679.522626255553, 8701.825963480742, 2164.935051948436, 2396.341006223294, 2446.645236440715, 2471.060996821205, 2490.3898544856534, 2482.9255122346267, 2491.6137998610243, 2494.5260400523935, 2497.1010436243027, 2497.687789026372, 2395.988020059906, 2451.9387015324583, 2480.578301688717, 2481.9751802482015, 2483.3543278747475, 2436.9390765230833, 2454.263720883737, 2459.606462965926, 2477.9752202478103, 2478.2689106713565, 2420.455397535558, 2442.78014978651, 2445.5475736988537, 2463.88912498938, 2479.3181874984525, 8707.956460217658, 8818.735437936872, 8820.2061814437, 8830.602622881986, 8850.026497085315, 5398.2982212312145, 5567.49892509672, 5574.247476590649, 5575.609707320448, 5577.135543990688, 3505.5618047744033, 3598.5501812273465, 3668.5781135169264, 3698.4637227601847, 3709.462127991453, 1055.6305293147414, 1060.6128763001525, 1070.9143268538498, 1077.6282182646974, 1079.2337440417314, 11880.346580938045, 11884.40577971098, 11890.702732431759, 11898.46456909441, 11898.940505297505, 4843.564079232886, 4856.80572777092, 4940.925886111711, 4967.428745694219, 4974.527419895104, 10192.439415832201, 10198.439085850201, 10207.183425326104, 10213.927537608593, 10226.437545934896, 5526.530244929226, 5545.140503222007, 5546.611737178358, 5551.111822108443, 5566.441396409012, 4417.249067658506, 4583.495815460296, 4796.0, 4964.975175124101, 4999.775010124553, 3814.7901865397116, 3911.6870650347905, 3919.6472317490993, 3946.427767973628, 3980.542237642708, 1304.178367628388, 1305.8367704036996, 1317.6574090736285, 1323.93380330985, 1326.4163767942075, 1156.2657712352548, 1174.770919670673, 1178.0810967445407, 1366.152985149214, 1385.4181243877595, 8001.919980800234, 8241.25828675422, 8244.54654993981, 8245.340372770164, 8254.05078415978, 515.3043391421551, 521.455079441984, 527.4751622135923, 530.8142150247382, 533.168257518265, 6163.19878415812, 6227.0, 6288.8427789304715, 6307.400796924285, 6319.431251187415, 10290.536925838354, 10556.366618002945, 10676.199285053652, 10678.252522323519, 10753.408562529135, 10393.896061039444, 10481.423521706227, 10532.15742740579, 10574.154067674568, 10609.522571484147, 8179.877301840358, 8278.089410164877, 8300.70947516822, 8345.123762005023, 8367.581620918929, 7662.080550333995, 7900.0, 7904.84190316179, 7917.841643166989, 7964.442489025712, 9249.537523123683, 9532.759801446517, 9551.42691438516, 9626.374285671409, 9698.806023879624, 9673.806523869624, 9834.508274586386, 9850.014998500093, 9867.457289849128, 9983.60065597368, 6709.698063587248, 6835.726570937107, 7343.632818358954, 7437.070366204224, 7529.058867641545, 8178.427510074238, 8200.343972482067, 8254.174582541698, 8260.132686067876, 8262.586870656563, 7230.927690723025, 7271.854562908818, 7324.450666200163, 7478.214787447458, 7486.326230639269, 7094.964525177547, 7180.281971802778, 7247.818804529929, 7269.927300726925, 7298.343149116605, 7218.0, 7667.501612395176, 7668.539887606538, 7681.0, 7684.9231507686445, 6885.724571017103, 6894.207166175954, 6967.407770339375, 6976.720931162697, 6985.0, 6947.096877405905, 7017.0, 7025.543339682904, 7033.577985320897, 7034.1910680270375], "unit": "score", "name": "mootools.html", "value": 4840.887899299323}, {"lowerIsBetter": false, "replicates": [288.71273083282136, 323.37427078602906, 324.3771957840945, 331.4531023810713, 335.6425406941606, 5396.244525766396, 6412.711427985741, 6667.599944003357, 6694.230163531195, 6703.396694297512, 6458.451031662303, 6605.0, 6609.933900660992, 6615.768448104317, 6652.168478940132, 4660.790264438108, 4725.55107264811, 4806.4232292125, 4832.951670483285, 4890.437599676038, 4339.023719663066, 4731.290306454025, 4805.3753012108555, 4842.467328593852, 4863.051704917542, 4807.326974223612, 4811.615070794328, 4817.301491283762, 4843.273508973647, 4844.951550484503, 3962.643362097425, 4072.572379900127, 4440.755758433284, 4833.975830120862, 4851.805927762921, 3352.2960178362573, 4062.1469491406842, 4082.4692789937417, 4086.734362266473, 4101.8974525636795, 6320.81037568869, 6323.33604971476, 6338.271098823649, 6349.492040636738, 6370.681465926685, 5599.160125981095, 5631.971840140773, 5636.408177141382, 5642.689652069134, 5659.490645841894, 7011.824704382431, 7012.544184628034, 7035.437165026786, 7038.366547010743, 7048.400885924702, 4536.56902594253, 4552.180607490651, 4685.929711054337, 4729.4797572267025, 4736.5026672199265, 7206.639668016578, 7238.2761723827725, 7279.563226206445, 7287.05268315121, 7314.7439839605895, 4828.444728856156, 4834.380482538389, 4834.830780922721, 4838.395200599925, 4841.273808928619, 4882.780274887638, 4889.4377146627885, 4897.118518666674, 4907.754612269444, 4909.337239472626, 5796.710164491758, 5802.506786923074, 5811.941880581225, 5817.680027598438, 5823.242978412779, 5758.7696492140685, 6748.696308666122, 6995.650217489105, 7077.0, 7102.92897071033, 1688.4512533426685, 1692.5768557860536, 1699.4731633193749, 1708.7607734917121, 1712.2808420463434, 1104.3263609198382, 1105.789899919013, 1130.5138790320077, 1132.7111586545377, 1135.812590922505, 5766.452187042224, 6204.255489341218, 6421.678916054178, 6616.669166541654, 6660.0, 7367.373773229336, 7370.115586129698, 7373.88939165913, 7374.262573742582, 7382.5570465772225, 6604.504662150358, 6615.6030638161865, 6621.5364924454825, 6625.238097618739, 6631.767888123893, 3814.122751767109, 3857.864974725871, 3866.8066596670055, 3873.6320049595242, 3878.612138786099, 7347.33873951347, 7625.428092893055, 7631.007968963999, 7661.731839385706, 7666.233376662401, 5714.885702286014, 7522.435817313723, 7537.472376933562, 7544.698212071456, 7548.396128309722, 6566.244881838458, 7625.199354067743, 7633.160352361347, 7648.273414025659, 7650.081990161217, 5614.5789065821045, 7153.785386438415, 7314.743983960536, 7318.1949985502615, 7343.963280183565, 6897.7585784497305, 7211.927880721126, 7228.168760592599, 7233.891491627524, 7281.01706269668, 7597.392208623407, 7645.961770191336, 7652.617369131633, 7657.889606007209, 7680.116786569616, 4584.587387135174, 4638.582527572535, 4649.418822647169, 4653.1391692535635, 4683.367745354333, 7303.707851685873, 7304.63476826146, 7305.671244793891, 7309.086364204474, 7332.853342933218, 6744.494162937701, 7053.576785392893, 7066.152061752623, 7072.328128827753, 7099.0, 5727.914081288867, 6997.755078572225, 7032.964835175791, 7041.225465198721, 7077.6461176941975, 5650.745716442688, 6898.482333886537, 6900.689468973807, 6910.343517365842, 6922.411595014279, 6766.594004359754, 7068.328508791862, 7072.858542829217, 7074.752383666547, 7090.688222678821, 6627.801165965029, 6702.463802895854, 6872.931270687229, 6889.104416425833, 6889.862202756017], "unit": "score", "name": "prototype.html", "value": 5127.919508739021}, {"lowerIsBetter": false, "replicates": [702.5152644675173, 735.2353552305602, 750.7544833963935, 765.6860687118283, 774.7443343696581, 14967.802575793938, 15108.697826043472, 15155.848441515582, 15205.847941520582, 15224.086554806705, 13846.584602461942, 14068.366923488442, 14217.360218790154, 14242.931780116482, 14256.643583910407, 747.7719295614835, 759.6429678051308, 903.7469508537604, 927.2952556057411, 927.378656300277, 926.9536523173848, 935.672514619881, 935.7333160049387, 935.9391639543408, 938.4556956964979, 967.6371360739722, 970.1026550440849, 975.9560819763092, 976.6630512473185, 979.6571200079951, 771.6411868481155, 960.8991055939096, 964.2189826240767, 982.2338575910801, 987.5407935310044, 703.8310805406717, 725.2022774947568, 734.9338559529668, 741.6921977379435, 744.7951813251399, 14905.03117297383, 14964.551063468005, 14987.925060374737, 15012.924935375362, 15048.247587620575, 12345.074119441078, 12367.257964522158, 12377.0, 12385.690357741038, 12723.918466930321, 9895.455749933752, 10061.396316220977, 10070.446125463097, 10117.241206909512, 10626.990435908576, 3433.4163192257374, 3504.386732321859, 3545.804980726059, 3620.456931460276, 3761.9435708464393, 60544.091838622895, 73707.89438158432, 74211.0, 75767.62116189439, 75959.86060209101, 9405.623775049058, 9417.529123543796, 9441.90558094424, 9654.806903862023, 9758.853617195748, 21039.368818935458, 21909.0, 21958.121675133134, 21960.121595136017, 21963.670544941837, 7390.704371825067, 7471.252874712594, 7551.207123252089, 7595.050618672666, 7806.765797026098, 3559.341521818472, 4058.0869304406865, 4093.3655283431117, 4126.8761937141935, 4251.915761480803, 3575.713942884563, 3635.381985062546, 3635.9091022724115, 3645.908852278661, 3649.525561676965, 578.9363170051291, 651.6481100205931, 666.3136968922018, 674.2515807453723, 688.703857341338, 554.8585110796721, 557.8075563930438, 599.868029033612, 600.5945986459122, 610.6003406612057, 7748.690052397841, 7920.445568810128, 7981.680732770624, 8078.636461359253, 8216.671333146727, 579.1370857422495, 601.4556826072411, 603.6016229288648, 604.8699529601068, 614.5176036811082, 3666.175110600147, 3864.246471937945, 3908.7459315144424, 3910.335243008695, 3922.1175235572337, 85593.0, 87747.56126219328, 87828.12171878327, 88034.55982720046, 88035.0, 73799.63100184572, 74066.14834629069, 74741.62629186819, 76304.61847690726, 76875.0, 66760.66619666967, 67237.6638116816, 67814.98277525841, 68365.43386693338, 69299.30700693029, 7855.175206603453, 7855.450118491651, 7875.094364148196, 7881.921180788118, 7905.644246008828, 48575.27137093017, 49292.50707492879, 49613.50386496089, 49718.751406242736, 50003.749981249865, 62088.0, 63228.0, 63877.6806115985, 64572.0, 67882.0, 10791.892081079088, 10862.511186996762, 11087.168462365516, 11089.112870970464, 11271.436428178722, 11733.882661173278, 11753.647390578297, 11781.175317727677, 11939.940300298444, 12109.878901210875, 11155.05182059534, 11236.583575149341, 11254.072230010566, 11500.94249528747, 12239.87760122423, 10204.744881378025, 10727.249092563447, 11453.656390308304, 11477.426128693698, 11650.941745291218, 9159.771005724644, 11219.943900280447, 11395.700577719437, 11454.713632159262, 11577.247478913843, 8130.715424960098, 9466.195373393339, 9603.087706667855, 9614.95192524033, 9695.854562181714, 9068.455892646462, 9618.470984095942, 9673.661421850484, 9697.0, 9877.50612469388], "unit": "score", "name": "yui.html", "value": 6850.472036927032}], "name": "dromaeo_css", "value": 7438.178022022926}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 111.0, 111.0, 112.0, 114.0, 117.0, 113.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [167.0, 140.0, 184.0, 154.0, 119.0, 142.0, 141.0, 118.0, 160.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 144.4}, {"lowerIsBetter": true, "replicates": [183.0, 184.0, 187.0, 184.0, 184.0, 185.0, 185.0, 180.0, 183.0, 183.0], "unit": "score", "name": "audio-dft", "value": 183.8}, {"lowerIsBetter": true, "replicates": [73.0, 79.0, 74.0, 116.0, 54.0, 57.0, 56.0, 59.0, 118.0, 56.0], "unit": "score", "name": "audio-fft", "value": 74.2}, {"lowerIsBetter": true, "replicates": [91.0, 93.0, 127.0, 78.0, 79.0, 80.0, 119.0, 80.0, 78.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 94.1}, {"lowerIsBetter": true, "replicates": [90.0, 86.0, 91.0, 88.0, 90.0, 87.0, 90.0, 88.0, 90.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.6}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 94.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 94.6}, {"lowerIsBetter": true, "replicates": [88.0, 88.0, 85.0, 86.0, 87.0, 87.0, 86.0, 88.0, 86.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 86.5}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 53.0, 54.0, 54.0, 53.0, 54.0, 65.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.2}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 74.0, 75.0, 71.0, 67.0, 67.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 99.0, 109.0, 110.0, 83.0, 81.0, 83.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 90.3}, {"lowerIsBetter": true, "replicates": [142.0, 131.0, 132.0, 134.0, 119.0, 119.0, 120.0, 119.0, 126.0, 135.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.7}, {"lowerIsBetter": true, "replicates": [146.0, 128.0, 140.0, 123.0, 148.0, 175.0, 142.0, 138.0, 133.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.1}, {"lowerIsBetter": true, "replicates": [65.0, 69.0, 69.0, 67.0, 68.0, 67.0, 66.0, 67.0, 65.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1427.6000000000001}]} 04:28:07 INFO - Return code: 0 04:28:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:28:07 ERROR - # TBPL SUCCESS # 04:28:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:28:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:28:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:28:07 INFO - 2016-04-05 04:28:07.139 screenresolution[1679:10211] starting screenresolution argv=screenresolution get 04:28:07 INFO - 2016-04-05 04:28:07.142 screenresolution[1679:10211] Display 0: 1600x1200x32@60 04:28:07 INFO - 2016-04-05 04:28:07.148 screenresolution[1680:10215] starting screenresolution argv=screenresolution list 04:28:07 INFO - Available Modes on Display 0 04:28:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:28:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:28:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:28:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:28:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:28:07 INFO - Intel Iris: 04:28:07 INFO - Chipset Model: Intel Iris 04:28:07 INFO - Type: GPU 04:28:07 INFO - Bus: Built-In 04:28:07 INFO - VRAM (Dynamic, Max): 1536 MB 04:28:07 INFO - Vendor: Intel (0x8086) 04:28:07 INFO - Device ID: 0x0a2e 04:28:07 INFO - Revision ID: 0x0009 04:28:07 INFO - Displays: 04:28:07 INFO - Display: 04:28:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:28:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:28:07 INFO - Display Serial Number: 1600x1200 60 04:28:07 INFO - Main Display: Yes 04:28:07 INFO - Mirror: Off 04:28:07 INFO - Online: Yes 04:28:07 INFO - Rotation: Supported 04:28:07 INFO - Return code: 0 04:28:07 INFO - Running post-action listener: _resource_record_post_action 04:28:07 INFO - Running post-run listener: _resource_record_post_run 04:28:08 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 37541376; Write bytes: 700512768; Read time: 392; Write time: 2160 04:28:08 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 388461056; Write bytes: 380614144; Read time: 29408; Write time: 680 04:28:08 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 36615680; Write bytes: 296989696; Read time: 379; Write time: 1437 04:28:08 INFO - Running post-run listener: _upload_blobber_files 04:28:08 INFO - Blob upload gear active. 04:28:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:28:08 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 04:28:08 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:28:08 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:28:08 INFO - (blobuploader) - INFO - Open directory for files ... 04:28:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:28:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:28:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:09 INFO - (blobuploader) - INFO - Done attempting. 04:28:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:28:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:28:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:10 INFO - (blobuploader) - INFO - Done attempting. 04:28:10 INFO - (blobuploader) - INFO - Iteration through files over. 04:28:10 INFO - Return code: 0 04:28:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:28:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:28:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf89409eb8e02d1aa689f2b4f0663733546fc697757b3a30cd57c919974f539068e2a7555a71c17500646cfd1a63819dbc13f01caac266a78f1114ddb800af80", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/656b7ae435160cb22455de18581412e4be8a5fe3a557ba6365edc15aa6fc0dd5ac7d496aed59dc01443a6508aa7f0e220ec9e2afe82d362b25d2ffa44c217b77"} 04:28:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:28:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:28:10 INFO - Contents: 04:28:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf89409eb8e02d1aa689f2b4f0663733546fc697757b3a30cd57c919974f539068e2a7555a71c17500646cfd1a63819dbc13f01caac266a78f1114ddb800af80", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/656b7ae435160cb22455de18581412e4be8a5fe3a557ba6365edc15aa6fc0dd5ac7d496aed59dc01443a6508aa7f0e220ec9e2afe82d362b25d2ffa44c217b77"} 04:28:10 INFO - Running post-run listener: copy_logs_to_upload_dir 04:28:10 INFO - Copying logs to upload dir... 04:28:10 INFO - mkdir: /builds/slave/test/build/upload/logs 04:28:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.189747 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-04-05 04:28:11.032928) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 04:28:11.036409) ========= 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.coJ319NwVU/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.qr1EDEz8ZJ/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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/Firefox/sha512/cf89409eb8e02d1aa689f2b4f0663733546fc697757b3a30cd57c919974f539068e2a7555a71c17500646cfd1a63819dbc13f01caac266a78f1114ddb800af80", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/656b7ae435160cb22455de18581412e4be8a5fe3a557ba6365edc15aa6fc0dd5ac7d496aed59dc01443a6508aa7f0e220ec9e2afe82d362b25d2ffa44c217b77"} build_url:https://queue.taskcluster.net/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/U6PQaT2OS7K8sN6Ccxjkkw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf89409eb8e02d1aa689f2b4f0663733546fc697757b3a30cd57c919974f539068e2a7555a71c17500646cfd1a63819dbc13f01caac266a78f1114ddb800af80", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/656b7ae435160cb22455de18581412e4be8a5fe3a557ba6365edc15aa6fc0dd5ac7d496aed59dc01443a6508aa7f0e220ec9e2afe82d362b25d2ffa44c217b77"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 04:28:11.063560) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 04:28:11.063887) ========= 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.coJ319NwVU/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.qr1EDEz8ZJ/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.005165 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 04:28:11.117065) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 04:28:11.117375) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 04:28:11.117793) ========= ========= Total master_lag: 6.37 =========