builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0120 starttime: 1458009477.96 results: success (0) buildid: 20160314173932 builduid: d10c784a16b64a6fa1c0168699f8108b revision: 422077f61bcb9ae19215de09e635c1082357233e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 19:37:57.962521) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 19:37:57.962961) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 19:37:57.963251) ========= 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.dI584WklZt/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.MyLWc0EM8s/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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.005419 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 19:37:57.993095) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 19:37:57.993382) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 19:37:58.011417) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 19:37:58.011790) ========= 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.dI584WklZt/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.MyLWc0EM8s/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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.005148 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 19:37:58.066028) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 19:37:58.066340) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 19:37:58.066691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-14 19:37:58.066975) ========= 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.dI584WklZt/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.MyLWc0EM8s/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-14 19:37:58-- 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% 173M=0s 2016-03-14 19:37:58 (173 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.523364 ========= master_lag: 1.91 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-14 19:38:00.498041) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 19:38:00.498327) ========= 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.dI584WklZt/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.MyLWc0EM8s/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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.026629 ========= master_lag: 0.46 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 19:38:00.988436) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-03-14 19:38:00.988740) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 422077f61bcb9ae19215de09e635c1082357233e --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 422077f61bcb9ae19215de09e635c1082357233e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dI584WklZt/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.MyLWc0EM8s/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-14 19:38:01,382 truncating revision to first 12 chars 2016-03-14 19:38:01,382 Setting DEBUG logging. 2016-03-14 19:38:01,382 attempt 1/10 2016-03-14 19:38:01,382 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/422077f61bcb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-14 19:38:01,983 unpacking tar archive at: mozilla-central-422077f61bcb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.841041 ========= master_lag: 6.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-03-14 19:38:07.951697) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-03-14 19:38:07.955250) ========= echo 422077f61bcb9ae19215de09e635c1082357233e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'422077f61bcb9ae19215de09e635c1082357233e'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dI584WklZt/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.MyLWc0EM8s/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 422077f61bcb9ae19215de09e635c1082357233e program finished with exit code 0 elapsedTime=0.006422 script_repo_revision: '422077f61bcb9ae19215de09e635c1082357233e' ========= master_lag: 1.38 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-03-14 19:38:09.343127) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 2 secs) (at 2016-03-14 19:38:09.343442) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 2 secs) (at 2016-03-14 19:38:12.007505) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 8 secs) (at 2016-03-14 19:38:12.007766) ========= /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.dI584WklZt/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.MyLWc0EM8s/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 19:38:12 INFO - MultiFileLogger online at 20160314 19:38:12 in /builds/slave/test 19:38:12 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 19:38:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:38:12 INFO - {'append_to_log': False, 19:38:12 INFO - 'base_work_dir': '/builds/slave/test', 19:38:12 INFO - 'blob_upload_branch': 'Firefox', 19:38:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:38:12 INFO - 'branch': 'Firefox', 19:38:12 INFO - 'buildbot_json_path': 'buildprops.json', 19:38:12 INFO - 'config_files': ('talos/mac_config.py',), 19:38:12 INFO - 'default_actions': ('clobber', 19:38:12 INFO - 'read-buildbot-config', 19:38:12 INFO - 'download-and-extract', 19:38:12 INFO - 'populate-webroot', 19:38:12 INFO - 'create-virtualenv', 19:38:12 INFO - 'install', 19:38:12 INFO - 'run-tests'), 19:38:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:38:12 INFO - 'download_minidump_stackwalk': True, 19:38:12 INFO - 'download_symbols': 'ondemand', 19:38:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:38:12 INFO - 'tooltool.py': '/tools/tooltool.py', 19:38:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:38:12 INFO - '/tools/misc-python/virtualenv.py')}, 19:38:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:38:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:38:12 INFO - 'installer_path': 'installer.exe', 19:38:12 INFO - 'log_level': 'info', 19:38:12 INFO - 'log_name': 'talos', 19:38:12 INFO - 'log_to_console': True, 19:38:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:38:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:38:12 INFO - 'opt_config_files': (), 19:38:12 INFO - 'pip_index': False, 19:38:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:38:12 INFO - 'cmd': ('bash', 19:38:12 INFO - '-c', 19:38:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:38:12 INFO - 'enabled': True, 19:38:12 INFO - 'halt_on_failure': False, 19:38:12 INFO - 'name': 'check_screen_resolution'},), 19:38:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:38:12 INFO - 'cmd': ('bash', 19:38:12 INFO - '-c', 19:38:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:38:12 INFO - 'enabled': True, 19:38:12 INFO - 'halt_on_failure': False, 19:38:12 INFO - 'name': 'check_screen_resolution'},), 19:38:12 INFO - 'run_cmd_checks_enabled': True, 19:38:12 INFO - 'sps_profile': False, 19:38:12 INFO - 'sps_profile_interval': 0, 19:38:12 INFO - 'suite': 'dromaeojs', 19:38:12 INFO - 'system_bits': '32', 19:38:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:38:12 INFO - 'title': 't-yosemite-r7-0120', 19:38:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:38:12 INFO - 'use_talos_json': True, 19:38:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:38:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:38:12 INFO - 'work_dir': 'build'} 19:38:12 INFO - ##### 19:38:12 INFO - ##### Running clobber step. 19:38:12 INFO - ##### 19:38:12 INFO - Running pre-action listener: _resource_record_pre_action 19:38:12 INFO - Running main action method: clobber 19:38:12 INFO - rmtree: /builds/slave/test/build 19:38:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:38:13 INFO - Running post-action listener: _resource_record_post_action 19:38:13 INFO - ##### 19:38:13 INFO - ##### Running read-buildbot-config step. 19:38:13 INFO - ##### 19:38:13 INFO - Running pre-action listener: _resource_record_pre_action 19:38:13 INFO - Running main action method: read_buildbot_config 19:38:13 INFO - Using buildbot properties: 19:38:13 INFO - { 19:38:13 INFO - "project": "", 19:38:13 INFO - "product": "firefox", 19:38:13 INFO - "script_repo_revision": "production", 19:38:13 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 19:38:13 INFO - "repository": "", 19:38:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 19:38:13 INFO - "buildid": "20160314173932", 19:38:13 INFO - "pgo_build": "False", 19:38:13 INFO - "basedir": "/builds/slave/test", 19:38:13 INFO - "buildnumber": 179, 19:38:13 INFO - "slavename": "t-yosemite-r7-0120", 19:38:13 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 19:38:13 INFO - "platform": "yosemite_r7", 19:38:13 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:38:13 INFO - "branch": "mozilla-central", 19:38:13 INFO - "repo_path": "mozilla-central", 19:38:13 INFO - "revision": "422077f61bcb9ae19215de09e635c1082357233e", 19:38:13 INFO - "stage_platform": "macosx64", 19:38:13 INFO - "builduid": "d10c784a16b64a6fa1c0168699f8108b", 19:38:13 INFO - "slavebuilddir": "test" 19:38:13 INFO - } 19:38:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 19:38:13 INFO - Running post-action listener: _resource_record_post_action 19:38:13 INFO - ##### 19:38:13 INFO - ##### Running download-and-extract step. 19:38:13 INFO - ##### 19:38:13 INFO - Running pre-action listener: _resource_record_pre_action 19:38:13 INFO - Running main action method: download_and_extract 19:38:13 INFO - mkdir: /builds/slave/test/build/tests 19:38: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')]} 19:38:13 INFO - https://queue.taskcluster.net/v1/task/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 19:38:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 19:38:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 19:38:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YTkz7EVASTyxOPO_E2OrLw/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 19:38:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YTkz7EVASTyxOPO_E2OrLw/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 19:38:15 INFO - Downloaded 1199 bytes. 19:38:15 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 19:38:15 INFO - Using the following test package requirements: 19:38:15 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 19:38:15 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:38:15 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 19:38:15 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:38:15 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 19:38:15 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:38:15 INFO - u'jsshell-mac.zip'], 19:38:15 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:38:15 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 19:38:15 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 19:38:15 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:38:15 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 19:38:15 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:38:15 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 19:38:15 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:38:15 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 19:38:15 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:38:15 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 19:38:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:38: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')]} 19:38:15 INFO - https://queue.taskcluster.net/v1/task/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:38:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:38:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:38:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YTkz7EVASTyxOPO_E2OrLw/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 19:38:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YTkz7EVASTyxOPO_E2OrLw/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 19:38:17 INFO - Downloaded 17852532 bytes. 19:38:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:38:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:38:20 INFO - Return code: 0 19:38:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:38:20 INFO - https://queue.taskcluster.net/v1/task/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:38:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:38:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:38:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YTkz7EVASTyxOPO_E2OrLw/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 19:38:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YTkz7EVASTyxOPO_E2OrLw/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 19:38:21 INFO - Downloaded 17852532 bytes. 19:38:21 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'] 19:38:21 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 19:38:24 INFO - Return code: 0 19:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:38:24 INFO - https://queue.taskcluster.net/v1/task/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:38:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 19:38:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 19:38:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YTkz7EVASTyxOPO_E2OrLw/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 19:38:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YTkz7EVASTyxOPO_E2OrLw/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 19:38:25 INFO - Downloaded 10845263 bytes. 19:38:25 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'] 19:38:25 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 19:38:26 INFO - Return code: 0 19:38:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:38:26 INFO - https://queue.taskcluster.net/v1/task/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:38:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:38:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:38:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 19:38:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YTkz7EVASTyxOPO_E2OrLw/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 19:38:57 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg: The read operation timed out 19:38:57 INFO - retry: attempt #1 caught exception: The read operation timed out 19:38:57 INFO - retry: Failed, sleeping 30 seconds before retrying 19:39:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #2 19:39:31 INFO - Downloaded 111258454 bytes. 19:39:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:39:31 INFO - mkdir: /builds/slave/test/properties 19:39:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:39:31 INFO - Writing to file /builds/slave/test/properties/build_url 19:39:31 INFO - Contents: 19:39:31 INFO - build_url:https://queue.taskcluster.net/v1/task/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:39:31 INFO - Running post-action listener: _resource_record_post_action 19:39:31 INFO - Running post-action listener: set_extra_try_arguments 19:39:31 INFO - ##### 19:39:31 INFO - ##### Running populate-webroot step. 19:39:31 INFO - ##### 19:39:31 INFO - Running pre-action listener: _resource_record_pre_action 19:39:31 INFO - Running main action method: populate_webroot 19:39:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:39:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:39:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:39:31 INFO - '--tppagecycles', 19:39:31 INFO - '7'], 19:39:31 INFO - 'tests': ['tsvgm']}}, 19:39:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:39:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:39:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:39:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:39:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:39:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:39:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:39:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:31 INFO - 'talos_options': ['--e10s'], 19:39:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:39:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:31 INFO - 'tests': ['damp', 'tps']}, 19:39:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:31 INFO - 'talos_options': ['--e10s'], 19:39:31 INFO - 'tests': ['damp', 'tps']}, 19:39:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:39:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:39:31 INFO - 'other': {'tests': ['a11yr', 19:39:31 INFO - 'ts_paint', 19:39:31 INFO - 'tpaint', 19:39:31 INFO - 'sessionrestore', 19:39:31 INFO - 'sessionrestore_no_auto_restore', 19:39:31 INFO - 'tabpaint']}, 19:39:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:39:31 INFO - 'tests': ['a11yr', 19:39:31 INFO - 'ts_paint', 19:39:31 INFO - 'tpaint', 19:39:31 INFO - 'sessionrestore', 19:39:31 INFO - 'sessionrestore_no_auto_restore', 19:39:31 INFO - 'tabpaint']}, 19:39:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:39:31 INFO - 'tests': ['a11yr', 19:39:31 INFO - 'ts_paint', 19:39:31 INFO - 'tpaint', 19:39:31 INFO - 'sessionrestore', 19:39:31 INFO - 'sessionrestore_no_auto_restore', 19:39:31 INFO - 'tabpaint']}, 19:39:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:39:31 INFO - 'tests': ['a11yr', 19:39:31 INFO - 'ts_paint', 19:39:31 INFO - 'tpaint', 19:39:31 INFO - 'sessionrestore', 19:39:31 INFO - 'sessionrestore_no_auto_restore', 19:39:31 INFO - 'tabpaint']}, 19:39:31 INFO - 'other_l64': {'tests': ['a11yr', 19:39:31 INFO - 'ts_paint', 19:39:31 INFO - 'tpaint', 19:39:31 INFO - 'sessionrestore', 19:39:31 INFO - 'sessionrestore_no_auto_restore', 19:39:31 INFO - 'tabpaint']}, 19:39:31 INFO - 'other_nol64': {'tests': ['a11yr', 19:39:31 INFO - 'ts_paint', 19:39:31 INFO - 'tpaint', 19:39:31 INFO - 'sessionrestore', 19:39:31 INFO - 'sessionrestore_no_auto_restore', 19:39:31 INFO - 'tabpaint']}, 19:39:31 INFO - 'svgr': {'tests': ['tsvgx', 19:39:31 INFO - 'tsvgr_opacity', 19:39:31 INFO - 'tart', 19:39:31 INFO - 'tscrollx', 19:39:31 INFO - 'cart']}, 19:39:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:39:31 INFO - 'tests': ['tsvgx', 19:39:31 INFO - 'tsvgr_opacity', 19:39:31 INFO - 'tart', 19:39:31 INFO - 'tscrollx', 19:39:31 INFO - 'cart']}, 19:39:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:31 INFO - 'tests': ['tp5o']}, 19:39:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:31 INFO - 'talos_options': ['--e10s'], 19:39:31 INFO - 'tests': ['tp5o']}, 19:39:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:31 INFO - 'talos_options': ['--xperf_path', 19:39:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:39:31 INFO - 'tests': ['tp5n']}, 19:39:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:31 INFO - 'talos_options': ['--e10s', 19:39:31 INFO - '--xperf_path', 19:39:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:39:31 INFO - 'tests': ['tp5n']}}, 19:39:31 INFO - 'talos.zip': {'path': '', 19:39:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:39:31 INFO - Running post-action listener: _resource_record_post_action 19:39:31 INFO - ##### 19:39:31 INFO - ##### Running create-virtualenv step. 19:39:31 INFO - ##### 19:39:31 INFO - Running pre-action listener: _resource_record_pre_action 19:39:31 INFO - Running main action method: create_virtualenv 19:39:31 INFO - Creating virtualenv /builds/slave/test/build/venv 19:39:31 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 19:39:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:39:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:39:32 INFO - Using real prefix '/tools/python27' 19:39:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:39:32 INFO - Installing distribute.............................................................................................................................................................................................done. 19:39:35 INFO - Installing pip.................done. 19:39:35 INFO - Return code: 0 19:39:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:39: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')]} 19:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39: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')]} 19:39:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100ba3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bab4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbabdc7650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a47d30>, '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 0x10086bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a3eb20>, '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.dI584WklZt/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.MyLWc0EM8s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 19:39: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', 'pip>=1.5'] in /builds/slave/test/build 19:39: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 pip>=1.5 19:39:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dI584WklZt/Render', 19:39:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:39:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:39:35 INFO - 'HOME': '/Users/cltbld', 19:39:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:39:35 INFO - 'LOGNAME': 'cltbld', 19:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:35 INFO - 'MOZ_NO_REMOTE': '1', 19:39:35 INFO - 'NO_EM_RESTART': '1', 19:39:35 INFO - 'PAGER': '/bin/cat', 19:39:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:35 INFO - 'PWD': '/builds/slave/test', 19:39:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:39:35 INFO - 'SHELL': '/bin/bash', 19:39:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MyLWc0EM8s/Listeners', 19:39:35 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 19:39:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:39:35 INFO - 'USER': 'cltbld', 19:39:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:39:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:35 INFO - 'XPC_FLAGS': '0x0', 19:39:35 INFO - 'XPC_SERVICE_NAME': '0', 19:39:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:39:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:35 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 19:39:35 INFO - Cleaning up... 19:39:35 INFO - Return code: 0 19:39:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:39: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')]} 19:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39: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')]} 19:39:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39: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', '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 0x100ba3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bab4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbabdc7650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a47d30>, '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 0x10086bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a3eb20>, '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.dI584WklZt/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.MyLWc0EM8s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 19:39: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', 'psutil>=0.7.1'] in /builds/slave/test/build 19:39: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 psutil>=0.7.1 19:39:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dI584WklZt/Render', 19:39:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:39:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:39:35 INFO - 'HOME': '/Users/cltbld', 19:39:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:39:35 INFO - 'LOGNAME': 'cltbld', 19:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:35 INFO - 'MOZ_NO_REMOTE': '1', 19:39:35 INFO - 'NO_EM_RESTART': '1', 19:39:35 INFO - 'PAGER': '/bin/cat', 19:39:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:35 INFO - 'PWD': '/builds/slave/test', 19:39:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:39:35 INFO - 'SHELL': '/bin/bash', 19:39:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MyLWc0EM8s/Listeners', 19:39:35 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 19:39:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:39:35 INFO - 'USER': 'cltbld', 19:39:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:39:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:35 INFO - 'XPC_FLAGS': '0x0', 19:39:35 INFO - 'XPC_SERVICE_NAME': '0', 19:39:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:36 INFO - Downloading/unpacking psutil>=0.7.1 19:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:39:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:39:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:39:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:39:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:39:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:39:39 INFO - Installing collected packages: psutil 19:39:39 INFO - Running setup.py install for psutil 19:39:39 INFO - building 'psutil._psutil_osx' extension 19:39:39 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 19:39:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 19:39:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 19:39:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 19:39:40 INFO - building 'psutil._psutil_posix' extension 19:39:40 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 19:39:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:39:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:39:40 INFO - ^ 19:39:40 INFO - 1 warning generated. 19:39:40 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 19:39:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:39:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:39:40 INFO - Successfully installed psutil 19:39:40 INFO - Cleaning up... 19:39:40 INFO - Return code: 0 19:39:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:39:40 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')]} 19:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:40 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')]} 19:39:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:40 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 0x100ba3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bab4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbabdc7650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a47d30>, '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 0x10086bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a3eb20>, '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.dI584WklZt/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.MyLWc0EM8s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 19:39:40 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 19:39:40 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 19:39:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dI584WklZt/Render', 19:39:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:39:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:39:40 INFO - 'HOME': '/Users/cltbld', 19:39:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:39:40 INFO - 'LOGNAME': 'cltbld', 19:39:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:40 INFO - 'MOZ_NO_REMOTE': '1', 19:39:40 INFO - 'NO_EM_RESTART': '1', 19:39:40 INFO - 'PAGER': '/bin/cat', 19:39:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:39:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:40 INFO - 'PWD': '/builds/slave/test', 19:39:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:39:40 INFO - 'SHELL': '/bin/bash', 19:39:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MyLWc0EM8s/Listeners', 19:39:40 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 19:39:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:39:40 INFO - 'USER': 'cltbld', 19:39:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:39:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:39:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:40 INFO - 'XPC_FLAGS': '0x0', 19:39:40 INFO - 'XPC_SERVICE_NAME': '0', 19:39:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:39: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 19:39: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 19:39: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 19:39: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 19:39: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 19:39: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 19:39:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:39:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:39:43 INFO - Installing collected packages: mozsystemmonitor 19:39:43 INFO - Running setup.py install for mozsystemmonitor 19:39:43 INFO - Successfully installed mozsystemmonitor 19:39:43 INFO - Cleaning up... 19:39:43 INFO - Return code: 0 19:39:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:39: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')]} 19:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39: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')]} 19:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:43 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 0x100ba3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bab4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbabdc7650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a47d30>, '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 0x10086bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a3eb20>, '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.dI584WklZt/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.MyLWc0EM8s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 19:39:43 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 19:39:43 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 19:39:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dI584WklZt/Render', 19:39:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:39:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:39:43 INFO - 'HOME': '/Users/cltbld', 19:39:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:39:43 INFO - 'LOGNAME': 'cltbld', 19:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:43 INFO - 'MOZ_NO_REMOTE': '1', 19:39:43 INFO - 'NO_EM_RESTART': '1', 19:39:43 INFO - 'PAGER': '/bin/cat', 19:39:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:43 INFO - 'PWD': '/builds/slave/test', 19:39:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:39:43 INFO - 'SHELL': '/bin/bash', 19:39:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MyLWc0EM8s/Listeners', 19:39:43 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 19:39:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:39:43 INFO - 'USER': 'cltbld', 19:39:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:39:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:43 INFO - 'XPC_FLAGS': '0x0', 19:39:43 INFO - 'XPC_SERVICE_NAME': '0', 19:39:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:44 INFO - Downloading/unpacking blobuploader==1.2.4 19:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:39:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:39:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:39:46 INFO - Downloading blobuploader-1.2.4.tar.gz 19:39:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:39:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:39:46 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 19:39:46 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 19:39:46 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 19:39:46 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 19:39:46 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 19:39:46 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 19:39:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:39:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:39:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:39:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:39:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:39:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:39:47 INFO - Downloading docopt-0.6.1.tar.gz 19:39:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:39:47 INFO - Installing collected packages: blobuploader, requests, docopt 19:39:47 INFO - Running setup.py install for blobuploader 19:39:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:39:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:39:47 INFO - Running setup.py install for requests 19:39:48 INFO - Running setup.py install for docopt 19:39:48 INFO - Successfully installed blobuploader requests docopt 19:39:48 INFO - Cleaning up... 19:39:48 INFO - Return code: 0 19:39:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:39:48 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')]} 19:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:48 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')]} 19:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:48 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 0x100ba3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bab4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbabdc7650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a47d30>, '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 0x10086bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a3eb20>, '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.dI584WklZt/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.MyLWc0EM8s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 19:39:48 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 19:39:48 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 19:39:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dI584WklZt/Render', 19:39:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:39:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:39:48 INFO - 'HOME': '/Users/cltbld', 19:39:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:39:48 INFO - 'LOGNAME': 'cltbld', 19:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:48 INFO - 'MOZ_NO_REMOTE': '1', 19:39:48 INFO - 'NO_EM_RESTART': '1', 19:39:48 INFO - 'PAGER': '/bin/cat', 19:39:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:48 INFO - 'PWD': '/builds/slave/test', 19:39:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:39:48 INFO - 'SHELL': '/bin/bash', 19:39:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MyLWc0EM8s/Listeners', 19:39:48 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 19:39:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:39:48 INFO - 'USER': 'cltbld', 19:39:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:39:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:48 INFO - 'XPC_FLAGS': '0x0', 19:39:48 INFO - 'XPC_SERVICE_NAME': '0', 19:39:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:39:48 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-lOqX16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:39:48 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-ewfe9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:39:48 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-0iXbzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:39:49 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-tYXwKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:39:49 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-u9A3xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:39:49 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-UPmJCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:39:49 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-GRb5yq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:39:49 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-5jkGk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:39:49 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-v9J9Yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:39:49 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-8B0P9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:39:49 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-SKDYxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:39:49 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-mJxv4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:39:49 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-4ZZyD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:39:50 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-GQcWlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:39:50 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-t5NbVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:39:50 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-z8yzaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:39:50 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-b27Str-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:39:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:39:50 INFO - Running setup.py install for manifestparser 19:39:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:39:50 INFO - Running setup.py install for mozcrash 19:39:50 INFO - Running setup.py install for mozdebug 19:39:50 INFO - Running setup.py install for mozdevice 19:39:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:39:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:39:51 INFO - Running setup.py install for mozfile 19:39:51 INFO - Running setup.py install for mozhttpd 19:39:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:39:51 INFO - Running setup.py install for mozinfo 19:39:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:39:51 INFO - Running setup.py install for mozInstall 19:39:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:39:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:39:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:39:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:39:51 INFO - Running setup.py install for mozleak 19:39:51 INFO - Running setup.py install for mozlog 19:39:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:39:51 INFO - Running setup.py install for moznetwork 19:39:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:39:52 INFO - Running setup.py install for mozprocess 19:39:52 INFO - Running setup.py install for mozprofile 19:39:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:39:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:39:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:39:52 INFO - Running setup.py install for mozrunner 19:39:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:39:52 INFO - Running setup.py install for mozscreenshot 19:39:52 INFO - Running setup.py install for moztest 19:39:52 INFO - Running setup.py install for mozversion 19:39:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:39:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:39:52 INFO - Cleaning up... 19:39:53 INFO - Return code: 0 19:39:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:39: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')]} 19:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39: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')]} 19:39:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100ba3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bab4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbabdc7650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a47d30>, '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 0x10086bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a3eb20>, '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.dI584WklZt/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.MyLWc0EM8s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 19:39:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:39:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dI584WklZt/Render', 19:39:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:39:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:39:53 INFO - 'HOME': '/Users/cltbld', 19:39:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:39:53 INFO - 'LOGNAME': 'cltbld', 19:39:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:53 INFO - 'MOZ_NO_REMOTE': '1', 19:39:53 INFO - 'NO_EM_RESTART': '1', 19:39:53 INFO - 'PAGER': '/bin/cat', 19:39:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:39:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:53 INFO - 'PWD': '/builds/slave/test', 19:39:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:39:53 INFO - 'SHELL': '/bin/bash', 19:39:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MyLWc0EM8s/Listeners', 19:39:53 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 19:39:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:39:53 INFO - 'USER': 'cltbld', 19:39:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:39:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:39:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:53 INFO - 'XPC_FLAGS': '0x0', 19:39:53 INFO - 'XPC_SERVICE_NAME': '0', 19:39:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:39:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:39:53 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-oDDf8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:39:53 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)) 19:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:39:53 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-mUOLoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:39:53 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)) 19:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:39:53 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-SnMqsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:39:53 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)) 19:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:39:53 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-qNmEpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:39:53 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)) 19:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:39:53 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-3UxGVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:39:53 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)) 19:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:39:53 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-fssFzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:39:53 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)) 19:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:39:53 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-JZ2s2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:39:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:39:54 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-G7RaVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:39:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:39:54 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-bvUQ8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:39:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:39:54 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-ViXLv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:39:54 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)) 19:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:39:54 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-iIP6un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:39:54 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)) 19:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:39:54 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-hnByoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:39:54 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)) 19:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:39:54 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-s4hON1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:39:54 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)) 19:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:39:54 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-Mtgyxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:39:54 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)) 19:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:39:54 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-kNxWAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:39:54 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)) 19:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:39:54 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-jkFy58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:39:54 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)) 19:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:39:54 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-R3nGWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:39:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:39:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:39:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:39:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:39:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:39:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:39:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:39: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 19:39: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 19:39: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 19:39: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 19:39: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 19:39: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 19:39:57 INFO - Downloading blessings-1.6.tar.gz 19:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:39:57 INFO - Installing collected packages: blessings 19:39:57 INFO - Running setup.py install for blessings 19:39:57 INFO - Successfully installed blessings 19:39:57 INFO - Cleaning up... 19:39:57 INFO - Return code: 0 19:39:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:39:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:39:58 INFO - Reading from file tmpfile_stdout 19:39:58 INFO - Current package versions: 19:39:58 INFO - blessings == 1.6 19:39:58 INFO - blobuploader == 1.2.4 19:39:58 INFO - docopt == 0.6.1 19:39:58 INFO - manifestparser == 1.1 19:39:58 INFO - mozInstall == 1.12 19:39:58 INFO - mozcrash == 0.17 19:39:58 INFO - mozdebug == 0.1 19:39:58 INFO - mozdevice == 0.48 19:39:58 INFO - mozfile == 1.2 19:39:58 INFO - mozhttpd == 0.7 19:39:58 INFO - mozinfo == 0.9 19:39:58 INFO - mozleak == 0.1 19:39:58 INFO - mozlog == 3.1 19:39:58 INFO - moznetwork == 0.27 19:39:58 INFO - mozprocess == 0.22 19:39:58 INFO - mozprofile == 0.28 19:39:58 INFO - mozrunner == 6.11 19:39:58 INFO - mozscreenshot == 0.1 19:39:58 INFO - mozsystemmonitor == 0.0 19:39:58 INFO - moztest == 0.7 19:39:58 INFO - mozversion == 1.4 19:39:58 INFO - psutil == 3.1.1 19:39:58 INFO - requests == 1.2.3 19:39:58 INFO - wsgiref == 0.1.2 19:39:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100ba3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bab4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbabdc7650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a47d30>, '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 0x10086bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a3eb20>, '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.dI584WklZt/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.MyLWc0EM8s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 19:39:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:39:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dI584WklZt/Render', 19:39:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:39:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:39:58 INFO - 'HOME': '/Users/cltbld', 19:39:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:39:58 INFO - 'LOGNAME': 'cltbld', 19:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:58 INFO - 'MOZ_NO_REMOTE': '1', 19:39:58 INFO - 'NO_EM_RESTART': '1', 19:39:58 INFO - 'PAGER': '/bin/cat', 19:39:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:58 INFO - 'PWD': '/builds/slave/test', 19:39:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:39:58 INFO - 'SHELL': '/bin/bash', 19:39:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MyLWc0EM8s/Listeners', 19:39:58 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 19:39:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:39:58 INFO - 'USER': 'cltbld', 19:39:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:39:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:58 INFO - 'XPC_FLAGS': '0x0', 19:39:58 INFO - 'XPC_SERVICE_NAME': '0', 19:39:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:58 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)) 19:39:58 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)) 19:39:58 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)) 19:39:58 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)) 19:39:58 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)) 19:39:58 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)) 19:39:58 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)) 19:39:58 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)) 19:39:58 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)) 19:39:58 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)) 19:39:58 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)) 19:39:58 INFO - Cleaning up... 19:39:58 INFO - Return code: 0 19:39:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:58 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 0x100ba3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bab4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbabdc7650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a47d30>, '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 0x10086bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a3eb20>, '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.dI584WklZt/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.MyLWc0EM8s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 19:39:58 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 19:39:58 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 19:39:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dI584WklZt/Render', 19:39:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:39:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:39:58 INFO - 'HOME': '/Users/cltbld', 19:39:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:39:58 INFO - 'LOGNAME': 'cltbld', 19:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:58 INFO - 'MOZ_NO_REMOTE': '1', 19:39:58 INFO - 'NO_EM_RESTART': '1', 19:39:58 INFO - 'PAGER': '/bin/cat', 19:39:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:58 INFO - 'PWD': '/builds/slave/test', 19:39:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:39:58 INFO - 'SHELL': '/bin/bash', 19:39:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MyLWc0EM8s/Listeners', 19:39:58 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 19:39:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:39:58 INFO - 'USER': 'cltbld', 19:39:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:39:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:58 INFO - 'XPC_FLAGS': '0x0', 19:39:58 INFO - 'XPC_SERVICE_NAME': '0', 19:39:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:58 INFO - Downloading/unpacking jsonschema 19:39:58 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 19:39:58 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 19:39:58 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 19:39:58 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 19:39:58 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 19:39:58 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 19:40:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:40:00 INFO - Downloading/unpacking functools32 (from jsonschema) 19:40:00 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 19:40:00 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 19:40:00 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 19:40:00 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 19:40:00 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 19:40:00 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 19:40:01 INFO - Downloading functools32-3.2.3-2.tar.gz 19:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:40:01 INFO - warning: no files found matching '*.txt' 19:40:01 INFO - no previously-included directories found matching 'build' 19:40:01 INFO - no previously-included directories found matching 'dist' 19:40:01 INFO - no previously-included directories found matching '.git*' 19:40:01 INFO - Installing collected packages: jsonschema, functools32 19:40:01 INFO - Running setup.py install for functools32 19:40:01 INFO - warning: no files found matching '*.txt' 19:40:01 INFO - no previously-included directories found matching 'build' 19:40:01 INFO - no previously-included directories found matching 'dist' 19:40:01 INFO - no previously-included directories found matching '.git*' 19:40:01 INFO - Successfully installed jsonschema functools32 19:40:01 INFO - Cleaning up... 19:40:01 INFO - Return code: 0 19:40:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:40:01 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')]} 19:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:01 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')]} 19:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:01 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 0x100ba3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bab4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbabdc7650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a47d30>, '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 0x10086bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a3eb20>, '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.dI584WklZt/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.MyLWc0EM8s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 19:40:01 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 19:40:01 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 19:40:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dI584WklZt/Render', 19:40:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:40:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:40:01 INFO - 'HOME': '/Users/cltbld', 19:40:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:40:01 INFO - 'LOGNAME': 'cltbld', 19:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:01 INFO - 'MOZ_NO_REMOTE': '1', 19:40:01 INFO - 'NO_EM_RESTART': '1', 19:40:01 INFO - 'PAGER': '/bin/cat', 19:40:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:01 INFO - 'PWD': '/builds/slave/test', 19:40:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:40:01 INFO - 'SHELL': '/bin/bash', 19:40:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MyLWc0EM8s/Listeners', 19:40:01 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 19:40:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:40:01 INFO - 'USER': 'cltbld', 19:40:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:40:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:01 INFO - 'XPC_FLAGS': '0x0', 19:40:01 INFO - 'XPC_SERVICE_NAME': '0', 19:40:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:01 INFO - Downloading/unpacking flake8 19:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:40:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:40:04 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 19:40:04 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 19:40:04 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 19:40:04 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 19:40:04 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 19:40:04 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 19:40:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:40:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:40:04 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 19:40:04 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 19:40:04 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 19:40:04 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 19:40:04 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 19:40:04 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 19:40:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:40:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:40:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:40:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:40:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:40:05 INFO - no previously-included directories found matching 'docs/_build' 19:40:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:40:05 INFO - Running setup.py install for pep8 19:40:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:40:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:40:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:40:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:40:05 INFO - no previously-included directories found matching 'docs/_build' 19:40:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:40:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:40:05 INFO - Cleaning up... 19:40:06 INFO - Return code: 0 19:40:06 INFO - Running post-action listener: _resource_record_post_action 19:40:06 INFO - Running post-action listener: _start_resource_monitoring 19:40:06 INFO - Starting resource monitoring. 19:40:06 INFO - ##### 19:40:06 INFO - ##### Running install step. 19:40:06 INFO - ##### 19:40:06 INFO - Running pre-action listener: _resource_record_pre_action 19:40:06 INFO - Running main action method: install 19:40:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:40:06 INFO - Reading from file tmpfile_stdout 19:40:06 INFO - Detecting whether we're running mozinstall >=1.0... 19:40:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:40:06 INFO - Reading from file tmpfile_stdout 19:40:06 INFO - Output received: 19:40:06 INFO - Usage: mozinstall [options] installer 19:40:06 INFO - Options: 19:40:06 INFO - -h, --help show this help message and exit 19:40:06 INFO - -d DEST, --destination=DEST 19:40:06 INFO - Directory to install application into. [default: 19:40:06 INFO - "/builds/slave/test"] 19:40:06 INFO - --app=APP Application being installed. [default: firefox] 19:40:06 INFO - mkdir: /builds/slave/test/build/application 19:40:06 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'] 19:40:06 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 19:40:40 INFO - Reading from file tmpfile_stdout 19:40:40 INFO - Output received: 19:40:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:40:40 INFO - Running post-action listener: _resource_record_post_action 19:40:40 INFO - ##### 19:40:40 INFO - ##### Running run-tests step. 19:40:40 INFO - ##### 19:40:40 INFO - Running pre-action listener: _resource_record_pre_action 19:40:40 INFO - Running main action method: run_tests 19:40:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:40:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:40:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:40:40 INFO - 2016-03-14 19:40:40.580 screenresolution[1648:7829] starting screenresolution argv=screenresolution get 19:40:40 INFO - 2016-03-14 19:40:40.583 screenresolution[1648:7829] Display 0: 1600x1200x32@60 19:40:40 INFO - 2016-03-14 19:40:40.589 screenresolution[1649:7831] starting screenresolution argv=screenresolution list 19:40:40 INFO - Available Modes on Display 0 19:40:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:40:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:40:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:40:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:40:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:40:40 INFO - Intel Iris: 19:40:40 INFO - Chipset Model: Intel Iris 19:40:40 INFO - Type: GPU 19:40:40 INFO - Bus: Built-In 19:40:40 INFO - VRAM (Dynamic, Max): 1536 MB 19:40:40 INFO - Vendor: Intel (0x8086) 19:40:40 INFO - Device ID: 0x0a2e 19:40:40 INFO - Revision ID: 0x0009 19:40:40 INFO - Displays: 19:40:40 INFO - Display: 19:40:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:40:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:40:40 INFO - Display Serial Number: 1600x1200 60 19:40:40 INFO - Main Display: Yes 19:40:40 INFO - Mirror: Off 19:40:40 INFO - Online: Yes 19:40:40 INFO - Rotation: Supported 19:40:40 INFO - Return code: 0 19:40:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:40:40 INFO - Python 2.7.3 19:40:40 INFO - Return code: 0 19:40:40 INFO - grabbing minidump binary from tooltool 19:40:40 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')]} 19:40:40 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 0x100a47d30>, '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 0x10086bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a3eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:40:40 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 19:40:40 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 19:40:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:40:40 INFO - Return code: 0 19:40:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:40:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:40:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:40:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:40:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:40:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:40:42 INFO - Return code: 0 19:40:42 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/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0120', '--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 19:40:42 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/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0120 --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 19:40:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dI584WklZt/Render', 19:40:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:40:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:40:42 INFO - 'HOME': '/Users/cltbld', 19:40:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:40:42 INFO - 'LOGNAME': 'cltbld', 19:40:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:40:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:40:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:42 INFO - 'MOZ_NO_REMOTE': '1', 19:40:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:40:42 INFO - 'NO_EM_RESTART': '1', 19:40:42 INFO - 'PAGER': '/bin/cat', 19:40:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:40:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:42 INFO - 'PWD': '/builds/slave/test', 19:40:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:40:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:40:42 INFO - 'SHELL': '/bin/bash', 19:40:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MyLWc0EM8s/Listeners', 19:40:42 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 19:40:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:40:42 INFO - 'USER': 'cltbld', 19:40:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:40:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:40:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:42 INFO - 'XPC_FLAGS': '0x0', 19:40:42 INFO - 'XPC_SERVICE_NAME': '0', 19:40:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:40:42 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/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0120', '--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 19:40:42 INFO - mozversion application_buildid: 20160314173932 19:40:42 INFO - mozversion application_changeset: 422077f61bcb9ae19215de09e635c1082357233e 19:40:42 INFO - mozversion application_display_name: Nightly 19:40:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:40:42 INFO - mozversion application_name: Firefox 19:40:42 INFO - mozversion application_remotingname: firefox 19:40:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:40:42 INFO - mozversion application_vendor: Mozilla 19:40:42 INFO - mozversion application_version: 48.0a1 19:40:42 INFO - mozversion platform_buildid: 20160314173932 19:40:42 INFO - mozversion platform_changeset: 422077f61bcb9ae19215de09e635c1082357233e 19:40:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:40:42 INFO - mozversion platform_version: 48.0a1 19:40:42 INFO - using testdate: 1458009642 19:40:42 INFO - actual date: 1458009642 19:40:42 INFO - starting webserver on 'localhost:49274' 19:40:42 INFO - SUITE-START | Running 2 tests 19:40:42 INFO - TEST-START | dromaeo_css 19:40:42 INFO - operating with platform_type : mac_ 19:40:42 INFO - Initialising browser for dromaeo_css test... 19:40:42 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmpM7FTUc/profile http://localhost:49274/getInfo.html) 19:40:44 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 19:40:44 INFO - PROCESS | 1667 | colorDepth:24 19:40:44 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 19:40:44 INFO - PROCESS | 1667 | __metrics 19:40:44 INFO - PROCESS | 1667 | 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" 19:40:44 ERROR - PROCESS | 1667 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:40:45 INFO - TEST-INFO | 1667: exit 0 19:40:45 INFO - Browser initialized. 19:40:45 INFO - Running cycle 1/1 for dromaeo_css test... 19:40:45 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmpM7FTUc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:40:57 INFO - PROCESS | 1670 | RSS: Main: 243109888 19:40:57 INFO - PROCESS | 1670 | 19:41:48 INFO - PROCESS | 1670 | 1458009708756 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] 19:43:59 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 19:44:00 INFO - PROCESS | 1670 | RSS: Main: 377413632 19:44:00 INFO - PROCESS | 1670 | 19:47:03 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 19:47:03 INFO - PROCESS | 1670 | RSS: Main: 368844800 19:47:03 INFO - PROCESS | 1670 | 19:50:05 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 19:50:06 INFO - PROCESS | 1670 | RSS: Main: 374743040 19:50:06 INFO - PROCESS | 1670 | 19:53:08 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 19:53:09 INFO - PROCESS | 1670 | RSS: Main: 331685888 19:53:09 INFO - PROCESS | 1670 | 19:56:12 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 19:56:12 INFO - PROCESS | 1670 | RSS: Main: 333197312 19:56:12 INFO - PROCESS | 1670 | 19:59:15 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 19:59:15 INFO - PROCESS | 1670 | RSS: Main: 418885632 19:59:15 INFO - PROCESS | 1670 | 19:59:15 INFO - PROCESS | 1670 | __start_tp_report 19:59:15 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 19:59:15 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 19:59:15 INFO - PROCESS | 1670 | |i|pagename|runs| 19:59:15 INFO - PROCESS | 1670 | |0;dojo.html;3201.391735570242;3469.843857026435;3507.6495549213555;3511.034465521983;3546.8049257290854;5643.548516118711;5648.124540696193;5653.123765816305;5660.9716951415285;5685.118806584981;5606;5654.123610840326;5665.575081868866;5680.744366503507;5681.630694004897;5139.023585518758;5155.690658560479;5176.430592634807;5190.169572868342;5241.554467870235;5256.658317209388;5259.211118332242;5263.131583288753;5264.684118952875;5267.315249017642;5192.1952097424955;5218;5220.086484865153;5246.370435547739;5246.396664383607;5220.608454365938;5263.815766448194;5277.155655095166;5289.814856480043;5349.5720342372515;5053.191489361721;5095.541401273903;5110.182370820651;5200.427952925213;5204.115300398941;5537.556995440355;5573;5573.136163894603;5607.831765047055;5653.57598180134;6216.564840461169;6232.096346029845;6232.501399888043;6234.719437625273;6237.750489980395;6103.87792244157;6111.908321375183;6237.906431403532;6314.273858506239;6327.955887278594;4641.90915134943;5402.37872644647;5771.711414429262;5774.855628609318;5792.275965504312;6272.341404152589;6279.560430769893;6284.717187726564;6285;6288.937110628926;5968.522518198533;6049.062395328731;6095.922000763747;6108.4807791338235;6127.417895299939;6170.475509581646;6226.533010024266;6250.4374606285655;6258.43674069336;6261;6161.353057928943;6194.721237544231;6224.470919971763;6224.844378890473;6243.531735119885;6061.515078793686;6112.381899552462;6115.666295175977;6126.700892189639;6155.692215389302;4903.166461701519;4907.411110666742;4908.901821963612;4927.063857867065;4943.8022479101155;4360.760158191267;4382.912341753147;4387.736735795798;4415.823367065345;4428.933565996513;5617.747201375948;5690.4025077367105;5709.115087161496;5723.971380143156;5724.398938111522;6114.023656277693;6151.538634602333;6176.289726681489;6221.5333849961435;6230.906536401958;5653.660780353192;5669.348024977098;5677.858053548694;5703.971480142655;5717.656940583578;5272.077386457355;5274.789008439696;5303.814366497231;5311.3891902431715;5312.681239125587;6202.038684003986;6278.183836101278;6314.400131987454;6320.336364681642;6349;5764.308283006066;6070.514358851369;6149.938500615115;6231.376862313732;6304.873902522016;5383.67697938125;6218.875622487434;6220.72006759706;6298.716557755004;6303.842403939938;5576.525995290446;6063.120847477003;6136.906367714697;6138.386161383826;6156.6921653918025;6132.08018797184;6176.011838105882;6187.16473276102;6197.907031394442;6251.71867265965;5932.635493836528;5998.880022399615;6079.939200607937;6085.878282434415;6104.320248149559;6006.099085137264;6089;6101.816945491642;6109.7387008107025;6123.969380153071;5950.196723442453;5968.671723055274;5991.730372133352;5999.220101386792;6005.7297421617;5221.791128354823;5875.294964604275;6106.725197366218;6107.234448619375;6132.938670613236;5838.153467747238;5882.382349853204;5959.76160953557;5985.790497332572;6000.729967151576 19:59:15 INFO - PROCESS | 1670 | |1;ext.html;495.5242966751918;578.9276340457443;579.9043157878948;623.6538721009839;637.7225906730571;29502.704972950265;29935.401291974176;29971.10086697397;38906.41640375397;39180.41229381554;42123.57876421235;42544.57455425445;42559.787201063955;42575;42819.78590107053;9452.480113593749;9683.515824208796;9686.66096686616;9687.515624218797;9691.370060946052;9412.34113612044;9567.091126342986;9568.33021688482;9571.760705982337;9585.472798996052;9662.75843103921;9724.562394692255;9724.805503889953;9743.95128024359;9747.122758951693;9620.951895240514;9692.079252471003;9698.224142068617;9702.854457183148;9712.368696034735;9501.809963800755;9626.229901607854;9642.75893102671;9648;9651.517424128766;40468.98827529306;40848.59151408478;40888.79555602233;40951.38572921409;40971;3228.4834426491648;3243.189202699325;3288.4574045282498;3305.8512366943546;3531.982340088309;26114.34714132143;27137.728622713916;27566.724332756618;29720.10839674813;29815.10554683363;2739.123480486245;2783.5061816950188;2838.9290267743263;2897.2901639098554;2991.7756168287465;470774;473628;473667;474008.6299568515;474015;68449.65775171093;68633.31366686369;68651.97022044673;68709;68874;73120.63439682768;73458.63270683719;73495;73542.63228683823;73688;14997;16209.59476013109;16402.671946561;16415.425460109076;16472.752908706378;11036.172287078502;11118.777624447466;11191.720206994727;12317.014638828872;12459.439325230387;15533.594638214725;18619.045000274775;20373.185072597225;20789.792102078787;20855.270065547633;8147.959260203661;8245.711400100967;9297.488638124969;9372.34393592442;9484.14642682148;878.3193025405362;941.2987324443196;971.5190980464715;989.8069876374038;1203.5546847666244;28282.85858570694;28510.714892850807;28966.42067158645;29495.26261843471;29825.552616710767;1077.5905156040653;1094.2176343914139;1114.765899161169;1223.6757259326287;1252.0984890878553;12265.386730663431;14932.850671493363;15097.169655668824;15277.854160937974;15297.388104475696;511426;512094;514885;516345;518210;59748;59962;60056;60151;60370;1311.9803202951964;1435.7846323051626;1472.3374481483374;1473.3075454536352;1529.4264650755968;25407.6188857171;26439.54582497981;28514.40800278638;28906.566401503573;29524;47340;47628.523714763796;48100;48221;48275.75862120667;365513;368351;368884;370801;476263;32648;33682.32635347328;33745.83127084349;33766.831165844014;33783.66216337805;40765.592344076176;41810.790946045076;41955.1608967825;42022.57977420309;42927;23704;32089.35821283608;33947.49078763771;36440.81779591191;36964;35877.10307242235;40503.1899362017;40912.97717557085;41009.794951025055;41968;31720.841395792875;38365.232695346494;38930.6106938927;39392.01519962024;39616.00959976023;38942.4851598752;39708.60291397049;39868.60131398649;40510.5566026891;40634.1873162541;30439.847800760854;30759.384812303182;30916.536251956688;31089.222769430944;31719.682803171672 19:59:15 INFO - PROCESS | 1670 | |2;jquery.html;359.5990470625253;362.0369816288671;364.11156777463;371.89586915663625;373.3466433740953;19504.41486755398;19598.70601940972;20291.695624565644;20372.592548149067;20394.6940795888;15180.54458366248;19839.5040123997;20041.799582004176;20045.398638040882;20067.59864802703;5437.483439073291;5593.161025846135;5594.300712410949;5610.943890561103;5647.09646456567;4062.3500239961613;4239.7668128252935;5589.636673616223;6035.60768550045;6284;6192.907106393408;6226.875462490748;6237.095621134933;6238.095476155955;6240.843978900519;5950.761969521214;6107.083937409379;6122.1735065766;6125.816225513242;6180.258368995705;3631.527901372831;5116.334876466036;5227.26818245446;5326.7070311132875;5340.973295133538;19922.10350534215;23906.7609323908;24129.517409651708;24288.514229715307;24336;2070.710100585919;2084.6143463459307;2208.6576580630026;2516.3834860459124;2579.548578998668;13421.463141474329;13781.310934453337;13962.860371396358;14136.717265654732;14483.855161448357;1615.1439736939442;1741.8171092035282;1769.3895606015903;1800.0549711401488;1812.3384964487998;93687;96457.51771241169;98358;98756;99104.7332622964;10590.788184236271;10944.39805810688;10944.4527773611;10979.066779323688;11096.5561377544;13376.6655833603;13405.329733513481;13461.394237259152;13471.528496502575;13489.52786652482;8284.8343033139;8295.709650162336;8296.917030829734;8387.538685372363;8400.873986890201;6666;8326.45878017927;8333.66665333392;8366.49801011929;8433.451825631315;4294.935575966363;4352.260115780325;4411.889702757457;4426.424564806619;4458.063806600585;1520.665453600206;1778.5642517583276;1795.2370242647085;1816.954576135607;1845.437141671776;883.4169448164309;951.8143961927358;958.4441024206084;971.8590804333473;989.8812142542942;15824.367025319088;19992.20031198765;20138.496537586678;20289.59420811605;20619;927.166167895756;953.9156942081436;1047.0367262118716;1062.1555863088709;1067.9626213082504;10522.000409961041;10678.51946662402;10688.091512221392;10709.946450267698;10725.946370268255;634902;647309;650748;653738;655893;86504;111598;114530;114994;119287.40356298164;916.7295647783786;986.452518852044;1001.9499025048864;1021.3157184686278;1023.4575674892319;14676.633084172981;17963.550911227325;18088.366907158186;18227.726584101514;18249.37655860349;49380.259296111304;49768.004639907726;49797.75101124471;50979.235311469616;51635.741821290656;65913.67043164754;72487;72829;73496;75494;7450.180480147071;7479.9154122653;7485.850282994418;7534.585597791955;7763.301302882767;9633.470159141314;10137.23970702215;10367.377957322586;10571.5242814072;11608.941955290507;10236.846447303446;10257;10421.478926053514;10489;10498;9951.751206219902;10162.187025038127;10230.23273254494;10360.222983276435;10426.530806113895;9779.848433344652;10453.529591168264;10663.360198388122;10764.51559679832;10777.838332424863;7386.335229829341;7428.2571742825285;7502.549847009197;7564.054493188351;7581.810454738455;7967.203279671987;9559.474228917197;10272.589096436059;10598.417087060287;10602.681919542427 19:59:15 INFO - PROCESS | 1670 | |3;mootools.html;1411.1603595860458;1509.7433436315825;1642.8603568696656;1913.2825190553542;2047.0890453748088;8006.279434850862;8734.650613975442;8925.732228033154;8930.642774289021;8930.91069089309;8555.101714319984;8810.603522841471;8810.823783524325;8818.4708917465;8829.95585022074;2164.8809315487642;2452.8896199670967;2505.649209110726;2514.786243169333;2530.0132948150144;2211.402921211272;2489.352768280242;2534.024400605771;2543.4277287610325;2547.503236868811;2448.6204638281097;2475.628655701641;2495.962560561593;2497.2008957133726;2501.199616122832;2450.0812195426624;2469.987650061747;2493.675822143128;2514.094925826701;2515.0694243129974;2470.7035155781423;2501.2746303571944;2507.987460062688;2511.3721569607596;2517.609770485578;9032.27741780656;9107.453552786788;9115.49864757438;9115.544222788834;9120;5482.890342193174;5644.322681278273;5651.519620832234;5654.264945557051;5654.406287339812;3505.526753888218;3627.0750958505414;3694.6305369463107;3700.4264339027495;3709.1839795245005;1040.4589613401065;1053.1048608682636;1061.8778840433372;1063.191974099682;1077.3966578715865;12239.93880030603;12253.081018923527;12254.44854981519;12255.69360765979;12290;4927.113119638428;4960.900781984412;5053.0399224147295;5058.418281897629;5070.366204224472;10320.896791031993;10329.483525823678;10335.586576536854;10347.741306467247;10385.948070259601;5595.720213989365;5625.71871406428;5626.212330273765;5631.493165615114;5637.915431268534;4320.092780516126;4436.955630443719;4446.377507149002;4457.732536047847;4831.661783675109;3816.8931010006786;3964.4053391991433;4022.6781857451333;4078.062045729499;4083.0813067059676;1180.2505409065134;1346.0913883128849;1347.1714895339296;1354.8712872277117;1362.2303398579968;1365.49476693622;1368.4047439363908;1372.7117305365784;1389;1389.8957578181678;8177.182281771775;8317.8336433271;8331.66673333072;8350.540720260322;8361.540115293596;527.085506645969;527.4040334422156;540.7674699879011;541.2882060091047;543.749875057478;6288.654124023131;6329.240491141092;6343.682815859189;6375.3624637536805;6392.169018027626;10534.789304214026;10740.194485413469;10756.354618722746;10770.946145269223;10893.891061089287;10409.9479502602;10564;10599.735006624742;10607.363558186533;10629.149668026539;8198.8360232795;8378.664853405795;8420.20008099242;8430.957845210734;8432.03031651368;6850.520463567503;8151.673933042612;8239.670413183645;8367.539785311623;8400.495970241805;7761.92238077612;8363.874541881754;9518.476483793458;9672;9943.453110079015;9418.62325506972;9643.27675424332;9782.902170978485;9820.361676491006;9840.950795245977;6697.196336439659;7324.230955749569;7478.102627684712;7492.175860655215;7576.772696819105;8299.128591497805;8364.49813011197;8394.958025209835;8395.118512556093;8395.874061888955;7259.346658800733;7296.59868707205;7355.2277010913085;7559.433042521943;7563.508371955805;7081.929180708127;7148.678309475982;7194.460415468965;7260.983462315175;7405.518641288299;7703.383729301754;7754.302112809874;7756.0304961879765;7767.339776119094;7773.41699372538;6952;6959.164900212007;7019.613921234381;7070.646467676698;7075.752348667772;7077.186123595852;7151.177614574391;7172.820679483055;7214.170370407471;7233.0597022386755 19:59:15 INFO - PROCESS | 1670 | |4;prototype.html;326.2724125200802;330.823009689816;336.77436117801074;337.2580323288765;341.7129611126653;6328.873422531552;6377.936220637792;6444.323346048668;6451.548391612589;6508.251551071617;6385.361463853612;6393.424591786738;6396.840078998028;6413.8396540086405;6415.486761059115;3685.3366394049062;4685.086408150395;4691.648126390534;4716.622670186377;4808.3989501312335;3814.256220037094;4642.419697537808;4752.574227731684;4752.809887604491;4791.113643975858;4674.415698037746;4685.929711054337;4761.976175122348;4764.499727528611;4772.880677983061;4073.2668119738437;4433.2685106957315;4760.3573517575205;4763.999560092368;4765.309030190603;3297.637259901433;3960.5049368828895;4035.556088830226;4042.6967977401814;4078.9592104079175;4818.951810481885;6011.57918945674;6027.306859711145;6045.33501314855;6081.817545473643;5410.323709536308;5425.267588875491;5425.294711687495;5432.533216031688;5458.208559758852;6675.365840245217;6710.664466776641;6742.325767423218;6745.29174436682;6753.15585551806;4291.939868862932;4539.2737162054245;4556.794944227518;4560.657950653715;4568.611668008223;7091.929080709178;7158.964205178992;7200.819979500502;7216.097987751531;7222.133343998754;4530.77346132692;4531.365608814768;4532.365468834366;4534.480948882096;4543.7728113594185;4601.493835678073;4606.539346065367;4614.307853821886;4614.377059097046;4625.93061104077;5409.891802164014;5414.269073675082;5414.891702166014;5419.83740487786;5423.050966080999;5769.365369809318;6541.6075035498025;6635.369639884203;6820.658967051727;6822;1569.6154442161744;1574.795276614033;1586.436814930706;1587.3888552906983;1592.6177717347753;1021.6526381030337;1024.6106479537727;1031.4224034540682;1043.1706793099352;1043.9530221140067;6099.725512351954;6211.472024877846;6317.736452709477;6360.681965901686;6379.71291291893;6902.792916212522;7100.325469080429;7102.467314951399;7107.182673992557;7134.393576545948;6359.872802543923;6373.490120790326;6377.681115944277;6381.138546296191;6392.808215753535;3684.8341824617955;3732.0669832541867;3734.626537346298;3735.1035751419463;3739;6059.272887253558;7223.097112860893;7424.406047516294;7428.294312040348;7458.105027396748;7292.19785823559;7332.413406927433;7332.5967071811565;7334.156571994182;7348.926510734825;7486.513376630502;7493.775186744407;7495.66269517873;7499.062617172854;7500.36246919018;7110.253423390676;7126.073610430611;7136.892946605702;7137.143542774693;7143.678534465857;6569.901451478136;6748.628825414649;6988.336108069725;6992.61540615271;6998.580085194904;7388.298111679382;7446.106467223968;7449.068866391701;7471.178170401143;7479.738209162653;4492.595666390041;4511.3458548510935;4513.75174365413;4534.387857639176;4539.727616342898;7014;7023.473239506955;7035.648217589202;7036.824079398056;7036.964815176096;6137.232845894263;6811.455083593201;6840.897386539305;6854.143232095988;6860.176778786577;5615.943840561542;6863;6909.1018167637885;6915.204751453647;6919.965400173169;5446.618736688552;6735.4274886635185;6744.123263975652;6753.2233793112455;6754.18949726036;6870.3473170048765;6892.278169788258;6898.241193468814;6900.861982760417;6903.5167538273845;5515.283013208417;6517.641529715911;6705.430038446591;6729.831754205989;6738.966305168443 19:59:15 INFO - PROCESS | 1670 | |5;yui.html;688.3116883116883;767.0297074201137;769.2499812682631;788.160608951467;798.6565776716012;14989.400423983041;15200.619984500394;15201.923990380046;15202.695946081085;15202.847971520281;12715.618531444048;13948.093373930687;14035.5087571935;14052;14063;738.9002484664569;930.6603089872182;946.460517505019;947.3605316411429;947.9857802132974;943.4952300519224;946.4226821638795;946.5361972633428;947.5735918836517;949.1173208915706;994.1649014827543;998.0418797953973;998.8351921932872;1005.7988402319529;1007.9949600251988;765.3226894198618;992.28059656749;994.5723338964242;994.7264502261863;998.8252055890263;569.8746275819313;732.0373708573209;738.822682556188;741.9851602967965;743.6542007966322;14688.045277057065;14908.552743417606;14928.25358732059;14931.701365972729;14953.252337383195;12519.061070419755;12557.874421255761;12603.621891343275;12688.619341419771;12912.418941147671;9757.414555126716;9860.50697465131;9919.950400247953;9941;10233.130183934374;3448.7241020718284;3508.122969257686;3525.383057964846;3576.445650924111;3578.624244454347;82968.58515707383;83371;83581;83605.58197209035;83663;9545;9618.855717164248;9636.951815240878;9812.01879812013;10020.148287395654;22643.20748773818;22658.320250392513;22714.886425567765;22732.2043728472;22738.09047638076;7293.744718934812;7500.58746768922;7503.737369192052;7563.584002879895;7577.128630207597;4105.0763578194665;4177.791110444466;4183.477065366829;4188.267053265667;4247.49030116388;3613.855445782139;3660.2496488220386;3664.9816750916607;3666.9633303667156;3668.0646435158865;652.6051738698114;657.9539432239793;664.8072059102806;667.0594461808827;671.8992151177265;587.5006244692063;598.3776872053103;609.0802887639696;616.7841255560518;624.3756243756244;7849.725259615886;8027.879581806277;8226.547539885243;8296.958515207385;8422.536760478233;545.9563234941195;587.528241754411;588.6718030190586;601.7322291580205;605.4641642146644;3712.2575484903127;3736.7384283100464;3744.85020599173;3918.1967696622123;4018.3771515415156;69738.65130674314;88137.55931220303;88601.55699221462;92280.92628884577;92592.07407925834;74652;75746.86379704309;75809;75887.24112758912;76297;26452.8096235666;26577.734222657913;26700.73299267021;26803.73196268012;28255.71744282572;7578.962105189439;7714.0743110824815;7739.458237923516;7854.4894581851995;7918.841623167619;49698.75150624224;49771.50228497814;50229.24656130234;50855.23717144172;51226;64674.676626616565;67772.3222767766;67948;68763.9977603601;69516.65241673759;10072.294939354175;10237.488125593542;10263.538140783832;10550.683479495627;10609.416482093251;8747.037825839025;10738.46307684597;10886.836697449386;11050.950159734812;11828.76342473163;10205.489725513546;10331.32846364984;10667.253292269466;10671.57313707443;10875.836862446911;10404.68785936423;10407.343091044406;10431.791364172523;10552.99746524079;10597.25819192649;10086.949565252127;10395.688129356131;10413.53139108757;10506.949305069433;10533.631322903662;8801.779955501164;8939;8994.100589940954;9074.546272686472;9267.304952128483;6506.804795856132;7959.681612735426;8596.140385961355;8688;8943.597538110671 19:59:15 INFO - PROCESS | 1670 | __end_tp_report 19:59:15 INFO - PROCESS | 1670 | __start_cc_report 19:59:15 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,1256 19:59:15 INFO - PROCESS | 1670 | __end_cc_report 19:59:15 INFO - PROCESS | 1670 | __startTimestamp1458010755708__endTimestamp 19:59:15 INFO - PROCESS | 1670 | 19:59:15 INFO - PROCESS | 1670 | ------- Summary: start ------- 19:59:15 INFO - PROCESS | 1670 | Number of tests: 6 19:59:15 INFO - PROCESS | 1670 | 19:59:15 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5698.50 Median:5932.64 stddev:624.61 (10.5%) stddev-sans-first:595.01 19:59:15 INFO - PROCESS | 1670 | Values: 3201.4 3469.8 3507.6 3511.0 3546.8 5643.5 5648.1 5653.1 5661.0 5685.1 5606.0 5654.1 5665.6 5680.7 5681.6 5139.0 5155.7 5176.4 5190.2 5241.6 5256.7 5259.2 5263.1 5264.7 5267.3 5192.2 5218.0 5220.1 5246.4 5246.4 5220.6 5263.8 5277.2 5289.8 5349.6 5053.2 5095.5 5110.2 5200.4 5204.1 5537.6 5573.0 5573.1 5607.8 5653.6 6216.6 6232.1 6232.5 6234.7 6237.8 6103.9 6111.9 6237.9 6314.3 6328.0 4641.9 5402.4 5771.7 5774.9 5792.3 6272.3 6279.6 6284.7 6285.0 6288.9 5968.5 6049.1 6095.9 6108.5 6127.4 6170.5 6226.5 6250.4 6258.4 6261.0 6161.4 6194.7 6224.5 6224.8 6243.5 6061.5 6112.4 6115.7 6126.7 6155.7 4903.2 4907.4 4908.9 4927.1 4943.8 4360.8 4382.9 4387.7 4415.8 4428.9 5617.7 5690.4 5709.1 5724.0 5724.4 6114.0 6151.5 6176.3 6221.5 6230.9 5653.7 5669.3 5677.9 5704.0 5717.7 5272.1 5274.8 5303.8 5311.4 5312.7 6202.0 6278.2 6314.4 6320.3 6349.0 5764.3 6070.5 6149.9 6231.4 6304.9 5383.7 6218.9 6220.7 6298.7 6303.8 5576.5 6063.1 6136.9 6138.4 6156.7 6132.1 6176.0 6187.2 6197.9 6251.7 5932.6 5998.9 6079.9 6085.9 6104.3 6006.1 6089.0 6101.8 6109.7 6124.0 5950.2 5968.7 5991.7 5999.2 6005.7 5221.8 5875.3 6106.7 6107.2 6132.9 5838.2 5882.4 5959.8 5985.8 6000.7 19:59:15 INFO - PROCESS | 1670 | 19:59:15 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:61532.79 Median:40506.87 stddev:122875.37 (303.3%) stddev-sans-first:123134.60 19:59:15 INFO - PROCESS | 1670 | Values: 495.5 578.9 579.9 623.7 637.7 29502.7 29935.4 29971.1 38906.4 39180.4 42123.6 42544.6 42559.8 42575.0 42819.8 9452.5 9683.5 9686.7 9687.5 9691.4 9412.3 9567.1 9568.3 9571.8 9585.5 9662.8 9724.6 9724.8 9744.0 9747.1 9621.0 9692.1 9698.2 9702.9 9712.4 9501.8 9626.2 9642.8 9648.0 9651.5 40469.0 40848.6 40888.8 40951.4 40971.0 3228.5 3243.2 3288.5 3305.9 3532.0 26114.3 27137.7 27566.7 29720.1 29815.1 2739.1 2783.5 2838.9 2897.3 2991.8 470774.0 473628.0 473667.0 474008.6 474015.0 68449.7 68633.3 68652.0 68709.0 68874.0 73120.6 73458.6 73495.0 73542.6 73688.0 14997.0 16209.6 16402.7 16415.4 16472.8 11036.2 11118.8 11191.7 12317.0 12459.4 15533.6 18619.0 20373.2 20789.8 20855.3 8148.0 8245.7 9297.5 9372.3 9484.1 878.3 941.3 971.5 989.8 1203.6 28282.9 28510.7 28966.4 29495.3 29825.6 1077.6 1094.2 1114.8 1223.7 1252.1 12265.4 14932.9 15097.2 15277.9 15297.4 511426.0 512094.0 514885.0 516345.0 518210.0 59748.0 59962.0 60056.0 60151.0 60370.0 1312.0 1435.8 1472.3 1473.3 1529.4 25407.6 26439.5 28514.4 28906.6 29524.0 47340.0 47628.5 48100.0 48221.0 48275.8 365513.0 368351.0 368884.0 370801.0 476263.0 32648.0 33682.3 33745.8 33766.8 33783.7 40765.6 41810.8 41955.2 42022.6 42927.0 23704.0 32089.4 33947.5 36440.8 36964.0 35877.1 40503.2 40913.0 41009.8 41968.0 31720.8 38365.2 38930.6 39392.0 39616.0 38942.5 39708.6 39868.6 40510.6 40634.2 30439.8 30759.4 30916.5 31089.2 31719.7 19:59:15 INFO - PROCESS | 1670 | 19:59:15 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:34722.89 Median:360.82 stddev:107029.98 (29663.1%) stddev-sans-first:107299.13 19:59:15 INFO - PROCESS | 1670 | Values: 359.6 362.0 364.1 371.9 373.3 19504.4 19598.7 20291.7 20372.6 20394.7 15180.5 19839.5 20041.8 20045.4 20067.6 5437.5 5593.2 5594.3 5610.9 5647.1 4062.4 4239.8 5589.6 6035.6 6284.0 6192.9 6226.9 6237.1 6238.1 6240.8 5950.8 6107.1 6122.2 6125.8 6180.3 3631.5 5116.3 5227.3 5326.7 5341.0 19922.1 23906.8 24129.5 24288.5 24336.0 2070.7 2084.6 2208.7 2516.4 2579.5 13421.5 13781.3 13962.9 14136.7 14483.9 1615.1 1741.8 1769.4 1800.1 1812.3 93687.0 96457.5 98358.0 98756.0 99104.7 10590.8 10944.4 10944.5 10979.1 11096.6 13376.7 13405.3 13461.4 13471.5 13489.5 8284.8 8295.7 8296.9 8387.5 8400.9 6666.0 8326.5 8333.7 8366.5 8433.5 4294.9 4352.3 4411.9 4426.4 4458.1 1520.7 1778.6 1795.2 1817.0 1845.4 883.4 951.8 958.4 971.9 989.9 15824.4 19992.2 20138.5 20289.6 20619.0 927.2 953.9 1047.0 1062.2 1068.0 10522.0 10678.5 10688.1 10709.9 10725.9 634902.0 647309.0 650748.0 653738.0 655893.0 86504.0 111598.0 114530.0 114994.0 119287.4 916.7 986.5 1001.9 1021.3 1023.5 14676.6 17963.6 18088.4 18227.7 18249.4 49380.3 49768.0 49797.8 50979.2 51635.7 65913.7 72487.0 72829.0 73496.0 75494.0 7450.2 7479.9 7485.9 7534.6 7763.3 9633.5 10137.2 10367.4 10571.5 11608.9 10236.8 10257.0 10421.5 10489.0 10498.0 9951.8 10162.2 10230.2 10360.2 10426.5 9779.8 10453.5 10663.4 10764.5 10777.8 7386.3 7428.3 7502.5 7564.1 7581.8 7967.2 9559.5 10272.6 10598.4 10602.7 19:59:15 INFO - PROCESS | 1670 | 19:59:15 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:6090.56 Median:5539.31 stddev:3226.60 (58.2%) stddev-sans-first:3216.48 19:59:15 INFO - PROCESS | 1670 | Values: 1411.2 1509.7 1642.9 1913.3 2047.1 8006.3 8734.7 8925.7 8930.6 8930.9 8555.1 8810.6 8810.8 8818.5 8830.0 2164.9 2452.9 2505.6 2514.8 2530.0 2211.4 2489.4 2534.0 2543.4 2547.5 2448.6 2475.6 2496.0 2497.2 2501.2 2450.1 2470.0 2493.7 2514.1 2515.1 2470.7 2501.3 2508.0 2511.4 2517.6 9032.3 9107.5 9115.5 9115.5 9120.0 5482.9 5644.3 5651.5 5654.3 5654.4 3505.5 3627.1 3694.6 3700.4 3709.2 1040.5 1053.1 1061.9 1063.2 1077.4 12239.9 12253.1 12254.4 12255.7 12290.0 4927.1 4960.9 5053.0 5058.4 5070.4 10320.9 10329.5 10335.6 10347.7 10385.9 5595.7 5625.7 5626.2 5631.5 5637.9 4320.1 4437.0 4446.4 4457.7 4831.7 3816.9 3964.4 4022.7 4078.1 4083.1 1180.3 1346.1 1347.2 1354.9 1362.2 1365.5 1368.4 1372.7 1389.0 1389.9 8177.2 8317.8 8331.7 8350.5 8361.5 527.1 527.4 540.8 541.3 543.7 6288.7 6329.2 6343.7 6375.4 6392.2 10534.8 10740.2 10756.4 10770.9 10893.9 10409.9 10564.0 10599.7 10607.4 10629.1 8198.8 8378.7 8420.2 8431.0 8432.0 6850.5 8151.7 8239.7 8367.5 8400.5 7761.9 8363.9 9518.5 9672.0 9943.5 9418.6 9643.3 9782.9 9820.4 9841.0 6697.2 7324.2 7478.1 7492.2 7576.8 8299.1 8364.5 8395.0 8395.1 8395.9 7259.3 7296.6 7355.2 7559.4 7563.5 7081.9 7148.7 7194.5 7261.0 7405.5 7703.4 7754.3 7756.0 7767.3 7773.4 6952.0 6959.2 7019.6 7070.6 7075.8 7077.2 7151.2 7172.8 7214.2 7233.1 19:59:15 INFO - PROCESS | 1670 | 19:59:15 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:5563.04 Median:6360.28 stddev:1790.46 (28.2%) stddev-sans-first:1751.81 19:59:15 INFO - PROCESS | 1670 | Values: 326.3 330.8 336.8 337.3 341.7 6328.9 6377.9 6444.3 6451.5 6508.3 6385.4 6393.4 6396.8 6413.8 6415.5 3685.3 4685.1 4691.6 4716.6 4808.4 3814.3 4642.4 4752.6 4752.8 4791.1 4674.4 4685.9 4762.0 4764.5 4772.9 4073.3 4433.3 4760.4 4764.0 4765.3 3297.6 3960.5 4035.6 4042.7 4079.0 4819.0 6011.6 6027.3 6045.3 6081.8 5410.3 5425.3 5425.3 5432.5 5458.2 6675.4 6710.7 6742.3 6745.3 6753.2 4291.9 4539.3 4556.8 4560.7 4568.6 7091.9 7159.0 7200.8 7216.1 7222.1 4530.8 4531.4 4532.4 4534.5 4543.8 4601.5 4606.5 4614.3 4614.4 4625.9 5409.9 5414.3 5414.9 5419.8 5423.1 5769.4 6541.6 6635.4 6820.7 6822.0 1569.6 1574.8 1586.4 1587.4 1592.6 1021.7 1024.6 1031.4 1043.2 1044.0 6099.7 6211.5 6317.7 6360.7 6379.7 6902.8 7100.3 7102.5 7107.2 7134.4 6359.9 6373.5 6377.7 6381.1 6392.8 3684.8 3732.1 3734.6 3735.1 3739.0 6059.3 7223.1 7424.4 7428.3 7458.1 7292.2 7332.4 7332.6 7334.2 7348.9 7486.5 7493.8 7495.7 7499.1 7500.4 7110.3 7126.1 7136.9 7137.1 7143.7 6569.9 6748.6 6988.3 6992.6 6998.6 7388.3 7446.1 7449.1 7471.2 7479.7 4492.6 4511.3 4513.8 4534.4 4539.7 7014.0 7023.5 7035.6 7036.8 7037.0 6137.2 6811.5 6840.9 6854.1 6860.2 5615.9 6863.0 6909.1 6915.2 6920.0 5446.6 6735.4 6744.1 6753.2 6754.2 6870.3 6892.3 6898.2 6900.9 6903.5 5515.3 6517.6 6705.4 6729.8 6739.0 19:59:15 INFO - PROCESS | 1670 | 19:59:15 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:16793.21 Median:607.27 stddev:23848.32 (3927.1%) stddev-sans-first:23884.57 19:59:15 INFO - PROCESS | 1670 | Values: 688.3 767.0 769.2 788.2 798.7 14989.4 15200.6 15201.9 15202.7 15202.8 12715.6 13948.1 14035.5 14052.0 14063.0 738.9 930.7 946.5 947.4 948.0 943.5 946.4 946.5 947.6 949.1 994.2 998.0 998.8 1005.8 1008.0 765.3 992.3 994.6 994.7 998.8 569.9 732.0 738.8 742.0 743.7 14688.0 14908.6 14928.3 14931.7 14953.3 12519.1 12557.9 12603.6 12688.6 12912.4 9757.4 9860.5 9920.0 9941.0 10233.1 3448.7 3508.1 3525.4 3576.4 3578.6 82968.6 83371.0 83581.0 83605.6 83663.0 9545.0 9618.9 9637.0 9812.0 10020.1 22643.2 22658.3 22714.9 22732.2 22738.1 7293.7 7500.6 7503.7 7563.6 7577.1 4105.1 4177.8 4183.5 4188.3 4247.5 3613.9 3660.2 3665.0 3667.0 3668.1 652.6 658.0 664.8 667.1 671.9 587.5 598.4 609.1 616.8 624.4 7849.7 8027.9 8226.5 8297.0 8422.5 546.0 587.5 588.7 601.7 605.5 3712.3 3736.7 3744.9 3918.2 4018.4 69738.7 88137.6 88601.6 92280.9 92592.1 74652.0 75746.9 75809.0 75887.2 76297.0 26452.8 26577.7 26700.7 26803.7 28255.7 7579.0 7714.1 7739.5 7854.5 7918.8 49698.8 49771.5 50229.2 50855.2 51226.0 64674.7 67772.3 67948.0 68764.0 69516.7 10072.3 10237.5 10263.5 10550.7 10609.4 8747.0 10738.5 10886.8 11051.0 11828.8 10205.5 10331.3 10667.3 10671.6 10875.8 10404.7 10407.3 10431.8 10553.0 10597.3 10086.9 10395.7 10413.5 10506.9 10533.6 8801.8 8939.0 8994.1 9074.5 9267.3 6506.8 7959.7 8596.1 8688.0 8943.6 19:59:15 INFO - PROCESS | 1670 | -------- Summary: end -------- 19:59:15 INFO - PROCESS | 1670 | 19:59:16 INFO - TEST-INFO | 1670: exit 0 19:59:16 INFO - TEST-OK | dromaeo_css | took 1113929ms 19:59:16 INFO - TEST-START | kraken 19:59:16 INFO - operating with platform_type : mac_ 19:59:16 INFO - Initialising browser for kraken test... 19:59:16 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmpe0NqgT/profile http://localhost:49274/getInfo.html) 19:59:18 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 19:59:18 INFO - PROCESS | 1676 | colorDepth:24 19:59:18 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 19:59:18 INFO - PROCESS | 1676 | __metrics 19:59:18 INFO - PROCESS | 1676 | 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" 19:59:18 ERROR - PROCESS | 1676 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:59:19 INFO - TEST-INFO | 1676: exit 0 19:59:19 INFO - Browser initialized. 19:59:19 INFO - Running cycle 1/1 for kraken test... 19:59:19 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmpe0NqgT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:59:31 INFO - PROCESS | 1678 | RSS: Main: 243392512 19:59:31 INFO - PROCESS | 1678 | 19:59:33 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 19:59:34 INFO - PROCESS | 1678 | RSS: Main: 288862208 19:59:34 INFO - PROCESS | 1678 | 19:59:37 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 19:59:37 INFO - PROCESS | 1678 | RSS: Main: 300244992 19:59:37 INFO - PROCESS | 1678 | 19:59:43 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 19:59:43 INFO - PROCESS | 1678 | RSS: Main: 287727616 19:59:43 INFO - PROCESS | 1678 | 19:59:45 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 19:59:46 INFO - PROCESS | 1678 | RSS: Main: 291663872 19:59:46 INFO - PROCESS | 1678 | 19:59:48 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:59:48 INFO - PROCESS | 1678 | RSS: Main: 291127296 19:59:48 INFO - PROCESS | 1678 | 19:59:51 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 19:59:52 INFO - PROCESS | 1678 | RSS: Main: 292626432 19:59:52 INFO - PROCESS | 1678 | 19:59:55 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 19:59:56 INFO - PROCESS | 1678 | RSS: Main: 289452032 19:59:56 INFO - PROCESS | 1678 | 19:59:59 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 19:59:59 INFO - PROCESS | 1678 | RSS: Main: 290832384 19:59:59 INFO - PROCESS | 1678 | 20:00:01 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:00:01 INFO - PROCESS | 1678 | RSS: Main: 329932800 20:00:01 INFO - PROCESS | 1678 | 20:00:03 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:00:04 INFO - PROCESS | 1678 | RSS: Main: 326934528 20:00:04 INFO - PROCESS | 1678 | 20:00:06 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:00:07 INFO - PROCESS | 1678 | RSS: Main: 324726784 20:00:07 INFO - PROCESS | 1678 | 20:00:09 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:00:10 INFO - PROCESS | 1678 | RSS: Main: 328249344 20:00:10 INFO - PROCESS | 1678 | 20:00:12 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:00:13 INFO - PROCESS | 1678 | RSS: Main: 321306624 20:00:13 INFO - PROCESS | 1678 | 20:00:15 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 20:00:15 INFO - PROCESS | 1678 | RSS: Main: 381124608 20:00:15 INFO - PROCESS | 1678 | 20:00:15 INFO - PROCESS | 1678 | __start_tp_report 20:00:15 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 20:00:15 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 20:00:15 INFO - PROCESS | 1678 | |i|pagename|runs| 20:00:15 INFO - PROCESS | 1678 | |0;ai-astar;111;107;113;112;112;113;118;110;112;117 20:00:15 INFO - PROCESS | 1678 | |1;audio-beat-detection;149;120;150;151;113;149;134;121;193;143 20:00:15 INFO - PROCESS | 1678 | |2;audio-dft;384;382;381;381;383;380;382;381;381;379 20:00:15 INFO - PROCESS | 1678 | |3;audio-fft;77;75;83;77;56;56;58;80;78;55 20:00:15 INFO - PROCESS | 1678 | |4;audio-oscillator;94;96;130;81;77;86;112;76;79;109 20:00:15 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;86;83;87;84;86;85;133;84;85;83 20:00:15 INFO - PROCESS | 1678 | |6;imaging-darkroom;157;156;156;158;158;155;156;157;167;253 20:00:15 INFO - PROCESS | 1678 | |7;imaging-desaturate;85;88;87;85;87;87;91;86;86;85 20:00:15 INFO - PROCESS | 1678 | |8;json-parse-financial;53;56;55;51;53;53;53;52;52;51 20:00:15 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;66;71;66;73;74;68;66;67;67;69 20:00:15 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;84;109;108;83;82;82;81;82;116;112 20:00:15 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;122;133;129;120;131;119;119;121;122;128 20:00:15 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;127;127;138;139;167;177;134;138;136;136 20:00:15 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;66;67;65;67;66;67;67;67;67;66 20:00:15 INFO - PROCESS | 1678 | __end_tp_report 20:00:15 INFO - PROCESS | 1678 | __start_cc_report 20:00:15 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1252 20:00:15 INFO - PROCESS | 1678 | __end_cc_report 20:00:15 INFO - PROCESS | 1678 | __startTimestamp1458010815268__endTimestamp 20:00:15 INFO - PROCESS | 1678 | 20:00:15 INFO - PROCESS | 1678 | ------- Summary: start ------- 20:00:15 INFO - PROCESS | 1678 | Number of tests: 14 20:00:15 INFO - PROCESS | 1678 | 20:00:15 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.50 stddev:3.17 (2.8%) stddev-sans-first:3.32 20:00:15 INFO - PROCESS | 1678 | Values: 111.0 107.0 113.0 112.0 112.0 113.0 118.0 110.0 112.0 117.0 20:00:15 INFO - PROCESS | 1678 | 20:00:15 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:149.00 stddev:22.79 (15.3%) stddev-sans-first:24.04 20:00:15 INFO - PROCESS | 1678 | Values: 149.0 120.0 150.0 151.0 113.0 149.0 134.0 121.0 193.0 143.0 20:00:15 INFO - PROCESS | 1678 | 20:00:15 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:381.40 Median:381.50 stddev:1.43 (0.4%) stddev-sans-first:1.17 20:00:15 INFO - PROCESS | 1678 | Values: 384.0 382.0 381.0 381.0 383.0 380.0 382.0 381.0 381.0 379.0 20:00:15 INFO - PROCESS | 1678 | 20:00:15 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:69.50 Median:77.00 stddev:11.62 (15.1%) stddev-sans-first:12.00 20:00:15 INFO - PROCESS | 1678 | Values: 77.0 75.0 83.0 77.0 56.0 56.0 58.0 80.0 78.0 55.0 20:00:15 INFO - PROCESS | 1678 | 20:00:15 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:80.00 stddev:18.01 (22.5%) stddev-sans-first:19.10 20:00:15 INFO - PROCESS | 1678 | Values: 94.0 96.0 130.0 81.0 77.0 86.0 112.0 76.0 79.0 109.0 20:00:15 INFO - PROCESS | 1678 | 20:00:15 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:89.60 Median:85.00 stddev:15.31 (18.0%) stddev-sans-first:16.18 20:00:15 INFO - PROCESS | 1678 | Values: 86.0 83.0 87.0 84.0 86.0 85.0 133.0 84.0 85.0 83.0 20:00:15 INFO - PROCESS | 1678 | 20:00:15 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:167.30 Median:157.50 stddev:30.30 (19.2%) stddev-sans-first:31.91 20:00:15 INFO - PROCESS | 1678 | Values: 157.0 156.0 156.0 158.0 158.0 155.0 156.0 157.0 167.0 253.0 20:00:15 INFO - PROCESS | 1678 | 20:00:15 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:86.70 Median:87.00 stddev:1.83 (2.1%) stddev-sans-first:1.83 20:00:15 INFO - PROCESS | 1678 | Values: 85.0 88.0 87.0 85.0 87.0 87.0 91.0 86.0 86.0 85.0 20:00:15 INFO - PROCESS | 1678 | 20:00:15 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:1.60 (3.0%) stddev-sans-first:1.69 20:00:15 INFO - PROCESS | 1678 | Values: 53.0 56.0 55.0 51.0 53.0 53.0 53.0 52.0 52.0 51.0 20:00:15 INFO - PROCESS | 1678 | 20:00:15 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:68.50 stddev:2.98 (4.4%) stddev-sans-first:3.00 20:00:15 INFO - PROCESS | 1678 | Values: 66.0 71.0 66.0 73.0 74.0 68.0 66.0 67.0 67.0 69.0 20:00:15 INFO - PROCESS | 1678 | 20:00:15 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:93.90 Median:82.00 stddev:15.10 (18.4%) stddev-sans-first:15.58 20:00:15 INFO - PROCESS | 1678 | Values: 84.0 109.0 108.0 83.0 82.0 82.0 81.0 82.0 116.0 112.0 20:00:15 INFO - PROCESS | 1678 | 20:00:15 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:125.00 stddev:5.30 (4.2%) stddev-sans-first:5.55 20:00:15 INFO - PROCESS | 1678 | Values: 122.0 133.0 129.0 120.0 131.0 119.0 119.0 121.0 122.0 128.0 20:00:15 INFO - PROCESS | 1678 | 20:00:15 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.90 Median:138.00 stddev:16.59 (12.0%) stddev-sans-first:16.70 20:00:15 INFO - PROCESS | 1678 | Values: 127.0 127.0 138.0 139.0 167.0 177.0 134.0 138.0 136.0 136.0 20:00:15 INFO - PROCESS | 1678 | 20:00:15 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 20:00:15 INFO - PROCESS | 1678 | Values: 66.0 67.0 65.0 67.0 66.0 67.0 67.0 67.0 67.0 66.0 20:00:15 INFO - PROCESS | 1678 | -------- Summary: end -------- 20:00:15 INFO - PROCESS | 1678 | 20:00:15 INFO - TEST-INFO | 1678: exit 0 20:00:16 INFO - TEST-OK | kraken | took 59767ms 20:00:16 INFO - SUITE-END | took 1173s 20:00:16 INFO - Completed test suite (00:19:34) 20:00:16 INFO - javascript benchmark 20:00:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3201.391735570242, 3469.843857026435, 3507.6495549213555, 3511.034465521983, 3546.8049257290854, 5643.548516118711, 5648.124540696193, 5653.123765816305, 5660.9716951415285, 5685.118806584981, 5606.0, 5654.123610840326, 5665.575081868866, 5680.744366503507, 5681.630694004897, 5139.023585518758, 5155.690658560479, 5176.430592634807, 5190.169572868342, 5241.554467870235, 5256.658317209388, 5259.211118332242, 5263.131583288753, 5264.684118952875, 5267.315249017642, 5192.1952097424955, 5218.0, 5220.086484865153, 5246.370435547739, 5246.396664383607, 5220.608454365938, 5263.815766448194, 5277.155655095166, 5289.814856480043, 5349.5720342372515, 5053.191489361721, 5095.541401273903, 5110.182370820651, 5200.427952925213, 5204.115300398941, 5537.556995440355, 5573.0, 5573.136163894603, 5607.831765047055, 5653.57598180134, 6216.564840461169, 6232.096346029845, 6232.501399888043, 6234.719437625273, 6237.750489980395, 6103.87792244157, 6111.908321375183, 6237.906431403532, 6314.273858506239, 6327.955887278594, 4641.90915134943, 5402.37872644647, 5771.711414429262, 5774.855628609318, 5792.275965504312, 6272.341404152589, 6279.560430769893, 6284.717187726564, 6285.0, 6288.937110628926, 5968.522518198533, 6049.062395328731, 6095.922000763747, 6108.4807791338235, 6127.417895299939, 6170.475509581646, 6226.533010024266, 6250.4374606285655, 6258.43674069336, 6261.0, 6161.353057928943, 6194.721237544231, 6224.470919971763, 6224.844378890473, 6243.531735119885, 6061.515078793686, 6112.381899552462, 6115.666295175977, 6126.700892189639, 6155.692215389302, 4903.166461701519, 4907.411110666742, 4908.901821963612, 4927.063857867065, 4943.8022479101155, 4360.760158191267, 4382.912341753147, 4387.736735795798, 4415.823367065345, 4428.933565996513, 5617.747201375948, 5690.4025077367105, 5709.115087161496, 5723.971380143156, 5724.398938111522, 6114.023656277693, 6151.538634602333, 6176.289726681489, 6221.5333849961435, 6230.906536401958, 5653.660780353192, 5669.348024977098, 5677.858053548694, 5703.971480142655, 5717.656940583578, 5272.077386457355, 5274.789008439696, 5303.814366497231, 5311.3891902431715, 5312.681239125587, 6202.038684003986, 6278.183836101278, 6314.400131987454, 6320.336364681642, 6349.0, 5764.308283006066, 6070.514358851369, 6149.938500615115, 6231.376862313732, 6304.873902522016, 5383.67697938125, 6218.875622487434, 6220.72006759706, 6298.716557755004, 6303.842403939938, 5576.525995290446, 6063.120847477003, 6136.906367714697, 6138.386161383826, 6156.6921653918025, 6132.08018797184, 6176.011838105882, 6187.16473276102, 6197.907031394442, 6251.71867265965, 5932.635493836528, 5998.880022399615, 6079.939200607937, 6085.878282434415, 6104.320248149559, 6006.099085137264, 6089.0, 6101.816945491642, 6109.7387008107025, 6123.969380153071, 5950.196723442453, 5968.671723055274, 5991.730372133352, 5999.220101386792, 6005.7297421617, 5221.791128354823, 5875.294964604275, 6106.725197366218, 6107.234448619375, 6132.938670613236, 5838.153467747238, 5882.382349853204, 5959.76160953557, 5985.790497332572, 6000.729967151576], "unit": "score", "name": "dojo.html", "value": 5660.325140298814}, {"lowerIsBetter": false, "replicates": [495.5242966751918, 578.9276340457443, 579.9043157878948, 623.6538721009839, 637.7225906730571, 29502.704972950265, 29935.401291974176, 29971.10086697397, 38906.41640375397, 39180.41229381554, 42123.57876421235, 42544.57455425445, 42559.787201063955, 42575.0, 42819.78590107053, 9452.480113593749, 9683.515824208796, 9686.66096686616, 9687.515624218797, 9691.370060946052, 9412.34113612044, 9567.091126342986, 9568.33021688482, 9571.760705982337, 9585.472798996052, 9662.75843103921, 9724.562394692255, 9724.805503889953, 9743.95128024359, 9747.122758951693, 9620.951895240514, 9692.079252471003, 9698.224142068617, 9702.854457183148, 9712.368696034735, 9501.809963800755, 9626.229901607854, 9642.75893102671, 9648.0, 9651.517424128766, 40468.98827529306, 40848.59151408478, 40888.79555602233, 40951.38572921409, 40971.0, 3228.4834426491648, 3243.189202699325, 3288.4574045282498, 3305.8512366943546, 3531.982340088309, 26114.34714132143, 27137.728622713916, 27566.724332756618, 29720.10839674813, 29815.10554683363, 2739.123480486245, 2783.5061816950188, 2838.9290267743263, 2897.2901639098554, 2991.7756168287465, 470774.0, 473628.0, 473667.0, 474008.6299568515, 474015.0, 68449.65775171093, 68633.31366686369, 68651.97022044673, 68709.0, 68874.0, 73120.63439682768, 73458.63270683719, 73495.0, 73542.63228683823, 73688.0, 14997.0, 16209.59476013109, 16402.671946561, 16415.425460109076, 16472.752908706378, 11036.172287078502, 11118.777624447466, 11191.720206994727, 12317.014638828872, 12459.439325230387, 15533.594638214725, 18619.045000274775, 20373.185072597225, 20789.792102078787, 20855.270065547633, 8147.959260203661, 8245.711400100967, 9297.488638124969, 9372.34393592442, 9484.14642682148, 878.3193025405362, 941.2987324443196, 971.5190980464715, 989.8069876374038, 1203.5546847666244, 28282.85858570694, 28510.714892850807, 28966.42067158645, 29495.26261843471, 29825.552616710767, 1077.5905156040653, 1094.2176343914139, 1114.765899161169, 1223.6757259326287, 1252.0984890878553, 12265.386730663431, 14932.850671493363, 15097.169655668824, 15277.854160937974, 15297.388104475696, 511426.0, 512094.0, 514885.0, 516345.0, 518210.0, 59748.0, 59962.0, 60056.0, 60151.0, 60370.0, 1311.9803202951964, 1435.7846323051626, 1472.3374481483374, 1473.3075454536352, 1529.4264650755968, 25407.6188857171, 26439.54582497981, 28514.40800278638, 28906.566401503573, 29524.0, 47340.0, 47628.523714763796, 48100.0, 48221.0, 48275.75862120667, 365513.0, 368351.0, 368884.0, 370801.0, 476263.0, 32648.0, 33682.32635347328, 33745.83127084349, 33766.831165844014, 33783.66216337805, 40765.592344076176, 41810.790946045076, 41955.1608967825, 42022.57977420309, 42927.0, 23704.0, 32089.35821283608, 33947.49078763771, 36440.81779591191, 36964.0, 35877.10307242235, 40503.1899362017, 40912.97717557085, 41009.794951025055, 41968.0, 31720.841395792875, 38365.232695346494, 38930.6106938927, 39392.01519962024, 39616.00959976023, 38942.4851598752, 39708.60291397049, 39868.60131398649, 40510.5566026891, 40634.1873162541, 30439.847800760854, 30759.384812303182, 30916.536251956688, 31089.222769430944, 31719.682803171672], "unit": "score", "name": "ext.html", "value": 19880.729359436056}, {"lowerIsBetter": false, "replicates": [359.5990470625253, 362.0369816288671, 364.11156777463, 371.89586915663625, 373.3466433740953, 19504.41486755398, 19598.70601940972, 20291.695624565644, 20372.592548149067, 20394.6940795888, 15180.54458366248, 19839.5040123997, 20041.799582004176, 20045.398638040882, 20067.59864802703, 5437.483439073291, 5593.161025846135, 5594.300712410949, 5610.943890561103, 5647.09646456567, 4062.3500239961613, 4239.7668128252935, 5589.636673616223, 6035.60768550045, 6284.0, 6192.907106393408, 6226.875462490748, 6237.095621134933, 6238.095476155955, 6240.843978900519, 5950.761969521214, 6107.083937409379, 6122.1735065766, 6125.816225513242, 6180.258368995705, 3631.527901372831, 5116.334876466036, 5227.26818245446, 5326.7070311132875, 5340.973295133538, 19922.10350534215, 23906.7609323908, 24129.517409651708, 24288.514229715307, 24336.0, 2070.710100585919, 2084.6143463459307, 2208.6576580630026, 2516.3834860459124, 2579.548578998668, 13421.463141474329, 13781.310934453337, 13962.860371396358, 14136.717265654732, 14483.855161448357, 1615.1439736939442, 1741.8171092035282, 1769.3895606015903, 1800.0549711401488, 1812.3384964487998, 93687.0, 96457.51771241169, 98358.0, 98756.0, 99104.7332622964, 10590.788184236271, 10944.39805810688, 10944.4527773611, 10979.066779323688, 11096.5561377544, 13376.6655833603, 13405.329733513481, 13461.394237259152, 13471.528496502575, 13489.52786652482, 8284.8343033139, 8295.709650162336, 8296.917030829734, 8387.538685372363, 8400.873986890201, 6666.0, 8326.45878017927, 8333.66665333392, 8366.49801011929, 8433.451825631315, 4294.935575966363, 4352.260115780325, 4411.889702757457, 4426.424564806619, 4458.063806600585, 1520.665453600206, 1778.5642517583276, 1795.2370242647085, 1816.954576135607, 1845.437141671776, 883.4169448164309, 951.8143961927358, 958.4441024206084, 971.8590804333473, 989.8812142542942, 15824.367025319088, 19992.20031198765, 20138.496537586678, 20289.59420811605, 20619.0, 927.166167895756, 953.9156942081436, 1047.0367262118716, 1062.1555863088709, 1067.9626213082504, 10522.000409961041, 10678.51946662402, 10688.091512221392, 10709.946450267698, 10725.946370268255, 634902.0, 647309.0, 650748.0, 653738.0, 655893.0, 86504.0, 111598.0, 114530.0, 114994.0, 119287.40356298164, 916.7295647783786, 986.452518852044, 1001.9499025048864, 1021.3157184686278, 1023.4575674892319, 14676.633084172981, 17963.550911227325, 18088.366907158186, 18227.726584101514, 18249.37655860349, 49380.259296111304, 49768.004639907726, 49797.75101124471, 50979.235311469616, 51635.741821290656, 65913.67043164754, 72487.0, 72829.0, 73496.0, 75494.0, 7450.180480147071, 7479.9154122653, 7485.850282994418, 7534.585597791955, 7763.301302882767, 9633.470159141314, 10137.23970702215, 10367.377957322586, 10571.5242814072, 11608.941955290507, 10236.846447303446, 10257.0, 10421.478926053514, 10489.0, 10498.0, 9951.751206219902, 10162.187025038127, 10230.23273254494, 10360.222983276435, 10426.530806113895, 9779.848433344652, 10453.529591168264, 10663.360198388122, 10764.51559679832, 10777.838332424863, 7386.335229829341, 7428.2571742825285, 7502.549847009197, 7564.054493188351, 7581.810454738455, 7967.203279671987, 9559.474228917197, 10272.589096436059, 10598.417087060287, 10602.681919542427], "unit": "score", "name": "jquery.html", "value": 9156.097449826791}, {"lowerIsBetter": false, "replicates": [1411.1603595860458, 1509.7433436315825, 1642.8603568696656, 1913.2825190553542, 2047.0890453748088, 8006.279434850862, 8734.650613975442, 8925.732228033154, 8930.642774289021, 8930.91069089309, 8555.101714319984, 8810.603522841471, 8810.823783524325, 8818.4708917465, 8829.95585022074, 2164.8809315487642, 2452.8896199670967, 2505.649209110726, 2514.786243169333, 2530.0132948150144, 2211.402921211272, 2489.352768280242, 2534.024400605771, 2543.4277287610325, 2547.503236868811, 2448.6204638281097, 2475.628655701641, 2495.962560561593, 2497.2008957133726, 2501.199616122832, 2450.0812195426624, 2469.987650061747, 2493.675822143128, 2514.094925826701, 2515.0694243129974, 2470.7035155781423, 2501.2746303571944, 2507.987460062688, 2511.3721569607596, 2517.609770485578, 9032.27741780656, 9107.453552786788, 9115.49864757438, 9115.544222788834, 9120.0, 5482.890342193174, 5644.322681278273, 5651.519620832234, 5654.264945557051, 5654.406287339812, 3505.526753888218, 3627.0750958505414, 3694.6305369463107, 3700.4264339027495, 3709.1839795245005, 1040.4589613401065, 1053.1048608682636, 1061.8778840433372, 1063.191974099682, 1077.3966578715865, 12239.93880030603, 12253.081018923527, 12254.44854981519, 12255.69360765979, 12290.0, 4927.113119638428, 4960.900781984412, 5053.0399224147295, 5058.418281897629, 5070.366204224472, 10320.896791031993, 10329.483525823678, 10335.586576536854, 10347.741306467247, 10385.948070259601, 5595.720213989365, 5625.71871406428, 5626.212330273765, 5631.493165615114, 5637.915431268534, 4320.092780516126, 4436.955630443719, 4446.377507149002, 4457.732536047847, 4831.661783675109, 3816.8931010006786, 3964.4053391991433, 4022.6781857451333, 4078.062045729499, 4083.0813067059676, 1180.2505409065134, 1346.0913883128849, 1347.1714895339296, 1354.8712872277117, 1362.2303398579968, 1365.49476693622, 1368.4047439363908, 1372.7117305365784, 1389.0, 1389.8957578181678, 8177.182281771775, 8317.8336433271, 8331.66673333072, 8350.540720260322, 8361.540115293596, 527.085506645969, 527.4040334422156, 540.7674699879011, 541.2882060091047, 543.749875057478, 6288.654124023131, 6329.240491141092, 6343.682815859189, 6375.3624637536805, 6392.169018027626, 10534.789304214026, 10740.194485413469, 10756.354618722746, 10770.946145269223, 10893.891061089287, 10409.9479502602, 10564.0, 10599.735006624742, 10607.363558186533, 10629.149668026539, 8198.8360232795, 8378.664853405795, 8420.20008099242, 8430.957845210734, 8432.03031651368, 6850.520463567503, 8151.673933042612, 8239.670413183645, 8367.539785311623, 8400.495970241805, 7761.92238077612, 8363.874541881754, 9518.476483793458, 9672.0, 9943.453110079015, 9418.62325506972, 9643.27675424332, 9782.902170978485, 9820.361676491006, 9840.950795245977, 6697.196336439659, 7324.230955749569, 7478.102627684712, 7492.175860655215, 7576.772696819105, 8299.128591497805, 8364.49813011197, 8394.958025209835, 8395.118512556093, 8395.874061888955, 7259.346658800733, 7296.59868707205, 7355.2277010913085, 7559.433042521943, 7563.508371955805, 7081.929180708127, 7148.678309475982, 7194.460415468965, 7260.983462315175, 7405.518641288299, 7703.383729301754, 7754.302112809874, 7756.0304961879765, 7767.339776119094, 7773.41699372538, 6952.0, 6959.164900212007, 7019.613921234381, 7070.646467676698, 7075.752348667772, 7077.186123595852, 7151.177614574391, 7172.820679483055, 7214.170370407471, 7233.0597022386755], "unit": "score", "name": "mootools.html", "value": 4893.542082428429}, {"lowerIsBetter": false, "replicates": [326.2724125200802, 330.823009689816, 336.77436117801074, 337.2580323288765, 341.7129611126653, 6328.873422531552, 6377.936220637792, 6444.323346048668, 6451.548391612589, 6508.251551071617, 6385.361463853612, 6393.424591786738, 6396.840078998028, 6413.8396540086405, 6415.486761059115, 3685.3366394049062, 4685.086408150395, 4691.648126390534, 4716.622670186377, 4808.3989501312335, 3814.256220037094, 4642.419697537808, 4752.574227731684, 4752.809887604491, 4791.113643975858, 4674.415698037746, 4685.929711054337, 4761.976175122348, 4764.499727528611, 4772.880677983061, 4073.2668119738437, 4433.2685106957315, 4760.3573517575205, 4763.999560092368, 4765.309030190603, 3297.637259901433, 3960.5049368828895, 4035.556088830226, 4042.6967977401814, 4078.9592104079175, 4818.951810481885, 6011.57918945674, 6027.306859711145, 6045.33501314855, 6081.817545473643, 5410.323709536308, 5425.267588875491, 5425.294711687495, 5432.533216031688, 5458.208559758852, 6675.365840245217, 6710.664466776641, 6742.325767423218, 6745.29174436682, 6753.15585551806, 4291.939868862932, 4539.2737162054245, 4556.794944227518, 4560.657950653715, 4568.611668008223, 7091.929080709178, 7158.964205178992, 7200.819979500502, 7216.097987751531, 7222.133343998754, 4530.77346132692, 4531.365608814768, 4532.365468834366, 4534.480948882096, 4543.7728113594185, 4601.493835678073, 4606.539346065367, 4614.307853821886, 4614.377059097046, 4625.93061104077, 5409.891802164014, 5414.269073675082, 5414.891702166014, 5419.83740487786, 5423.050966080999, 5769.365369809318, 6541.6075035498025, 6635.369639884203, 6820.658967051727, 6822.0, 1569.6154442161744, 1574.795276614033, 1586.436814930706, 1587.3888552906983, 1592.6177717347753, 1021.6526381030337, 1024.6106479537727, 1031.4224034540682, 1043.1706793099352, 1043.9530221140067, 6099.725512351954, 6211.472024877846, 6317.736452709477, 6360.681965901686, 6379.71291291893, 6902.792916212522, 7100.325469080429, 7102.467314951399, 7107.182673992557, 7134.393576545948, 6359.872802543923, 6373.490120790326, 6377.681115944277, 6381.138546296191, 6392.808215753535, 3684.8341824617955, 3732.0669832541867, 3734.626537346298, 3735.1035751419463, 3739.0, 6059.272887253558, 7223.097112860893, 7424.406047516294, 7428.294312040348, 7458.105027396748, 7292.19785823559, 7332.413406927433, 7332.5967071811565, 7334.156571994182, 7348.926510734825, 7486.513376630502, 7493.775186744407, 7495.66269517873, 7499.062617172854, 7500.36246919018, 7110.253423390676, 7126.073610430611, 7136.892946605702, 7137.143542774693, 7143.678534465857, 6569.901451478136, 6748.628825414649, 6988.336108069725, 6992.61540615271, 6998.580085194904, 7388.298111679382, 7446.106467223968, 7449.068866391701, 7471.178170401143, 7479.738209162653, 4492.595666390041, 4511.3458548510935, 4513.75174365413, 4534.387857639176, 4539.727616342898, 7014.0, 7023.473239506955, 7035.648217589202, 7036.824079398056, 7036.964815176096, 6137.232845894263, 6811.455083593201, 6840.897386539305, 6854.143232095988, 6860.176778786577, 5615.943840561542, 6863.0, 6909.1018167637885, 6915.204751453647, 6919.965400173169, 5446.618736688552, 6735.4274886635185, 6744.123263975652, 6753.2233793112455, 6754.18949726036, 6870.3473170048765, 6892.278169788258, 6898.241193468814, 6900.861982760417, 6903.5167538273845, 5515.283013208417, 6517.641529715911, 6705.430038446591, 6729.831754205989, 6738.966305168443], "unit": "score", "name": "prototype.html", "value": 4973.20602367545}, {"lowerIsBetter": false, "replicates": [688.3116883116883, 767.0297074201137, 769.2499812682631, 788.160608951467, 798.6565776716012, 14989.400423983041, 15200.619984500394, 15201.923990380046, 15202.695946081085, 15202.847971520281, 12715.618531444048, 13948.093373930687, 14035.5087571935, 14052.0, 14063.0, 738.9002484664569, 930.6603089872182, 946.460517505019, 947.3605316411429, 947.9857802132974, 943.4952300519224, 946.4226821638795, 946.5361972633428, 947.5735918836517, 949.1173208915706, 994.1649014827543, 998.0418797953973, 998.8351921932872, 1005.7988402319529, 1007.9949600251988, 765.3226894198618, 992.28059656749, 994.5723338964242, 994.7264502261863, 998.8252055890263, 569.8746275819313, 732.0373708573209, 738.822682556188, 741.9851602967965, 743.6542007966322, 14688.045277057065, 14908.552743417606, 14928.25358732059, 14931.701365972729, 14953.252337383195, 12519.061070419755, 12557.874421255761, 12603.621891343275, 12688.619341419771, 12912.418941147671, 9757.414555126716, 9860.50697465131, 9919.950400247953, 9941.0, 10233.130183934374, 3448.7241020718284, 3508.122969257686, 3525.383057964846, 3576.445650924111, 3578.624244454347, 82968.58515707383, 83371.0, 83581.0, 83605.58197209035, 83663.0, 9545.0, 9618.855717164248, 9636.951815240878, 9812.01879812013, 10020.148287395654, 22643.20748773818, 22658.320250392513, 22714.886425567765, 22732.2043728472, 22738.09047638076, 7293.744718934812, 7500.58746768922, 7503.737369192052, 7563.584002879895, 7577.128630207597, 4105.0763578194665, 4177.791110444466, 4183.477065366829, 4188.267053265667, 4247.49030116388, 3613.855445782139, 3660.2496488220386, 3664.9816750916607, 3666.9633303667156, 3668.0646435158865, 652.6051738698114, 657.9539432239793, 664.8072059102806, 667.0594461808827, 671.8992151177265, 587.5006244692063, 598.3776872053103, 609.0802887639696, 616.7841255560518, 624.3756243756244, 7849.725259615886, 8027.879581806277, 8226.547539885243, 8296.958515207385, 8422.536760478233, 545.9563234941195, 587.528241754411, 588.6718030190586, 601.7322291580205, 605.4641642146644, 3712.2575484903127, 3736.7384283100464, 3744.85020599173, 3918.1967696622123, 4018.3771515415156, 69738.65130674314, 88137.55931220303, 88601.55699221462, 92280.92628884577, 92592.07407925834, 74652.0, 75746.86379704309, 75809.0, 75887.24112758912, 76297.0, 26452.8096235666, 26577.734222657913, 26700.73299267021, 26803.73196268012, 28255.71744282572, 7578.962105189439, 7714.0743110824815, 7739.458237923516, 7854.4894581851995, 7918.841623167619, 49698.75150624224, 49771.50228497814, 50229.24656130234, 50855.23717144172, 51226.0, 64674.676626616565, 67772.3222767766, 67948.0, 68763.9977603601, 69516.65241673759, 10072.294939354175, 10237.488125593542, 10263.538140783832, 10550.683479495627, 10609.416482093251, 8747.037825839025, 10738.46307684597, 10886.836697449386, 11050.950159734812, 11828.76342473163, 10205.489725513546, 10331.32846364984, 10667.253292269466, 10671.57313707443, 10875.836862446911, 10404.68785936423, 10407.343091044406, 10431.791364172523, 10552.99746524079, 10597.25819192649, 10086.949565252127, 10395.688129356131, 10413.53139108757, 10506.949305069433, 10533.631322903662, 8801.779955501164, 8939.0, 8994.100589940954, 9074.546272686472, 9267.304952128483, 6506.804795856132, 7959.681612735426, 8596.140385961355, 8688.0, 8943.597538110671], "unit": "score", "name": "yui.html", "value": 6645.1461794457}], "name": "dromaeo_css", "value": 7418.1810528303395}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 113.0, 112.0, 112.0, 113.0, 118.0, 110.0, 112.0, 117.0], "unit": "score", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [149.0, 120.0, 150.0, 151.0, 113.0, 149.0, 134.0, 121.0, 193.0, 143.0], "unit": "score", "name": "audio-beat-detection", "value": 142.3}, {"lowerIsBetter": true, "replicates": [384.0, 382.0, 381.0, 381.0, 383.0, 380.0, 382.0, 381.0, 381.0, 379.0], "unit": "score", "name": "audio-dft", "value": 381.4}, {"lowerIsBetter": true, "replicates": [77.0, 75.0, 83.0, 77.0, 56.0, 56.0, 58.0, 80.0, 78.0, 55.0], "unit": "score", "name": "audio-fft", "value": 69.5}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 130.0, 81.0, 77.0, 86.0, 112.0, 76.0, 79.0, 109.0], "unit": "score", "name": "audio-oscillator", "value": 94.0}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 87.0, 84.0, 86.0, 85.0, 133.0, 84.0, 85.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 89.6}, {"lowerIsBetter": true, "replicates": [157.0, 156.0, 156.0, 158.0, 158.0, 155.0, 156.0, 157.0, 167.0, 253.0], "unit": "score", "name": "imaging-darkroom", "value": 167.3}, {"lowerIsBetter": true, "replicates": [85.0, 88.0, 87.0, 85.0, 87.0, 87.0, 91.0, 86.0, 86.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 86.7}, {"lowerIsBetter": true, "replicates": [53.0, 56.0, 55.0, 51.0, 53.0, 53.0, 53.0, 52.0, 52.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 52.9}, {"lowerIsBetter": true, "replicates": [66.0, 71.0, 66.0, 73.0, 74.0, 68.0, 66.0, 67.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [84.0, 109.0, 108.0, 83.0, 82.0, 82.0, 81.0, 82.0, 116.0, 112.0], "unit": "score", "name": "stanford-crypto-aes", "value": 93.9}, {"lowerIsBetter": true, "replicates": [122.0, 133.0, 129.0, 120.0, 131.0, 119.0, 119.0, 121.0, 122.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [127.0, 127.0, 138.0, 139.0, 167.0, 177.0, 134.0, 138.0, 136.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.9}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 65.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1691.6000000000006}]} 20:00:16 INFO - Return code: 0 20:00:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:00:16 ERROR - # TBPL SUCCESS # 20:00:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:00:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:00:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:00:16 INFO - 2016-03-14 20:00:16.618 screenresolution[1682:10170] starting screenresolution argv=screenresolution get 20:00:16 INFO - 2016-03-14 20:00:16.620 screenresolution[1682:10170] Display 0: 1600x1200x32@60 20:00:16 INFO - 2016-03-14 20:00:16.626 screenresolution[1683:10173] starting screenresolution argv=screenresolution list 20:00:16 INFO - Available Modes on Display 0 20:00:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:00:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:00:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:00:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:00:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:00:16 INFO - Intel Iris: 20:00:16 INFO - Chipset Model: Intel Iris 20:00:16 INFO - Type: GPU 20:00:16 INFO - Bus: Built-In 20:00:16 INFO - VRAM (Dynamic, Max): 1536 MB 20:00:16 INFO - Vendor: Intel (0x8086) 20:00:16 INFO - Device ID: 0x0a2e 20:00:16 INFO - Revision ID: 0x0009 20:00:16 INFO - Displays: 20:00:16 INFO - Display: 20:00:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:00:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:00:16 INFO - Display Serial Number: 1600x1200 60 20:00:16 INFO - Main Display: Yes 20:00:16 INFO - Mirror: Off 20:00:16 INFO - Online: Yes 20:00:16 INFO - Rotation: Supported 20:00:16 INFO - Return code: 0 20:00:16 INFO - Running post-action listener: _resource_record_post_action 20:00:16 INFO - Running post-run listener: _resource_record_post_run 20:00:17 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 45392384; Write bytes: 714257408; Read time: 529; Write time: 2177 20:00:17 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 391795200; Write bytes: 386006016; Read time: 30344; Write time: 671 20:00:17 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 43581952; Write bytes: 308856832; Read time: 508; Write time: 1465 20:00:17 INFO - Running post-run listener: _upload_blobber_files 20:00:17 INFO - Blob upload gear active. 20:00:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:00:17 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 20:00:17 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'] 20:00:17 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 20:00:18 INFO - (blobuploader) - INFO - Open directory for files ... 20:00:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:00:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:00:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:00:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:00:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:00:19 INFO - (blobuploader) - INFO - Done attempting. 20:00:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:00:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:00:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:00:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:00:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:00:20 INFO - (blobuploader) - INFO - Done attempting. 20:00:20 INFO - (blobuploader) - INFO - Iteration through files over. 20:00:20 INFO - Return code: 0 20:00:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:00:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:00:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98d5129d4f8c468392c72678cf2b0b540517eaadd77bc828d8b7fa18e8cc1aececc69a5666ed2291f15dc80a51be82a80f8a91849c854a0ffa43c2e3c8011370", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb31e4d2055263009edd26b83b7b0d3189e19ab0bdcfffbea38ed6f2050505959a1334dbc1ea26afc164b805c1333440c709d32f8eaecac57b352603c664aa18"} 20:00:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:00:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:00:20 INFO - Contents: 20:00:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98d5129d4f8c468392c72678cf2b0b540517eaadd77bc828d8b7fa18e8cc1aececc69a5666ed2291f15dc80a51be82a80f8a91849c854a0ffa43c2e3c8011370", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb31e4d2055263009edd26b83b7b0d3189e19ab0bdcfffbea38ed6f2050505959a1334dbc1ea26afc164b805c1333440c709d32f8eaecac57b352603c664aa18"} 20:00:20 INFO - Running post-run listener: copy_logs_to_upload_dir 20:00:20 INFO - Copying logs to upload dir... 20:00:20 INFO - mkdir: /builds/slave/test/build/upload/logs 20:00:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1328.029157 ========= master_lag: 0.94 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 8 secs) (at 2016-03-14 20:00:20.978238) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 20:00:20.986225) ========= 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.dI584WklZt/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.MyLWc0EM8s/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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/98d5129d4f8c468392c72678cf2b0b540517eaadd77bc828d8b7fa18e8cc1aececc69a5666ed2291f15dc80a51be82a80f8a91849c854a0ffa43c2e3c8011370", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb31e4d2055263009edd26b83b7b0d3189e19ab0bdcfffbea38ed6f2050505959a1334dbc1ea26afc164b805c1333440c709d32f8eaecac57b352603c664aa18"} build_url:https://queue.taskcluster.net/v1/task/YTkz7EVASTyxOPO_E2OrLw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010851 build_url: 'https://queue.taskcluster.net/v1/task/YTkz7EVASTyxOPO_E2OrLw/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/98d5129d4f8c468392c72678cf2b0b540517eaadd77bc828d8b7fa18e8cc1aececc69a5666ed2291f15dc80a51be82a80f8a91849c854a0ffa43c2e3c8011370", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb31e4d2055263009edd26b83b7b0d3189e19ab0bdcfffbea38ed6f2050505959a1334dbc1ea26afc164b805c1333440c709d32f8eaecac57b352603c664aa18"}' ========= master_lag: 0.18 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 20:00:21.178248) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 12 secs) (at 2016-03-14 20:00:21.178530) ========= 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.dI584WklZt/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.MyLWc0EM8s/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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.005143 ========= master_lag: 12.54 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 12 secs) (at 2016-03-14 20:00:33.722922) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 20:00:33.723257) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 20:00:33.762876) ========= ========= Total master_lag: 23.61 =========