builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0178 starttime: 1458959757.68 results: success (0) buildid: 20160325144302 builduid: 45444673fb3642f28fbcb96a55172248 revision: 5629a22932f74f3e2d647c3462c32191a791afed ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 19:35:57.677067) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 19:35:57.677484) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 19:35:57.677769) ========= 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.d4lId5Ruwh/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.kmZWM5DSaZ/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.005594 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 19:35:57.711002) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 19:35:57.711316) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 19:35:57.729200) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 19:35:57.729500) ========= 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.d4lId5Ruwh/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.kmZWM5DSaZ/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.005775 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 19:35:57.777835) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 19:35:57.778153) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 19:35:57.778501) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 19:35:57.778772) ========= 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.d4lId5Ruwh/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.kmZWM5DSaZ/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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-25 19:35:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 45.4M=0s 2016-03-25 19:35:57 (45.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100894 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 19:35:57.895690) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 19:35:57.899061) ========= 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.d4lId5Ruwh/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.kmZWM5DSaZ/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.026392 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 19:35:57.947803) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-25 19:35:57.951221) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5629a22932f74f3e2d647c3462c32191a791afed --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5629a22932f74f3e2d647c3462c32191a791afed --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.d4lId5Ruwh/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.kmZWM5DSaZ/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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-25 19:35:58,029 truncating revision to first 12 chars 2016-03-25 19:35:58,030 Setting DEBUG logging. 2016-03-25 19:35:58,030 attempt 1/10 2016-03-25 19:35:58,030 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5629a22932f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-25 19:35:59,530 unpacking tar archive at: mozilla-aurora-5629a22932f7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.751156 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-25 19:35:59.744139) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 19:35:59.744474) ========= echo 5629a22932f74f3e2d647c3462c32191a791afed in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5629a22932f74f3e2d647c3462c32191a791afed'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.d4lId5Ruwh/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.kmZWM5DSaZ/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 5629a22932f74f3e2d647c3462c32191a791afed program finished with exit code 0 elapsedTime=0.005403 script_repo_revision: '5629a22932f74f3e2d647c3462c32191a791afed' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 19:35:59.793718) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 19:35:59.794074) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 19:35:59.807628) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-03-25 19:35:59.807929) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.d4lId5Ruwh/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.kmZWM5DSaZ/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:35:59 INFO - MultiFileLogger online at 20160325 19:35:59 in /builds/slave/test 19:35:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:35:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:35:59 INFO - {'append_to_log': False, 19:35:59 INFO - 'base_work_dir': '/builds/slave/test', 19:35:59 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:35:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:35:59 INFO - 'branch': 'Mozilla-Aurora', 19:35:59 INFO - 'buildbot_json_path': 'buildprops.json', 19:35:59 INFO - 'config_files': ('talos/mac_config.py',), 19:35:59 INFO - 'default_actions': ('clobber', 19:35:59 INFO - 'read-buildbot-config', 19:35:59 INFO - 'download-and-extract', 19:35:59 INFO - 'populate-webroot', 19:35:59 INFO - 'create-virtualenv', 19:35:59 INFO - 'install', 19:35:59 INFO - 'run-tests'), 19:35:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:35:59 INFO - 'download_minidump_stackwalk': True, 19:35:59 INFO - 'download_symbols': 'ondemand', 19:35:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:35:59 INFO - 'tooltool.py': '/tools/tooltool.py', 19:35:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:35:59 INFO - '/tools/misc-python/virtualenv.py')}, 19:35:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:35:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:35:59 INFO - 'installer_path': 'installer.exe', 19:35:59 INFO - 'log_level': 'info', 19:35:59 INFO - 'log_name': 'talos', 19:35:59 INFO - 'log_to_console': True, 19:35:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:35:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:35:59 INFO - 'opt_config_files': (), 19:35:59 INFO - 'pip_index': False, 19:35:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:35:59 INFO - 'cmd': ('bash', 19:35:59 INFO - '-c', 19:35:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:35:59 INFO - 'enabled': True, 19:35:59 INFO - 'halt_on_failure': False, 19:35:59 INFO - 'name': 'check_screen_resolution'},), 19:35:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:35:59 INFO - 'cmd': ('bash', 19:35:59 INFO - '-c', 19:35:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:35:59 INFO - 'enabled': True, 19:35:59 INFO - 'halt_on_failure': False, 19:35:59 INFO - 'name': 'check_screen_resolution'},), 19:35:59 INFO - 'run_cmd_checks_enabled': True, 19:35:59 INFO - 'sps_profile': False, 19:35:59 INFO - 'sps_profile_interval': 0, 19:35:59 INFO - 'suite': 'dromaeojs', 19:35:59 INFO - 'system_bits': '32', 19:35:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:35:59 INFO - 'title': 't-yosemite-r7-0178', 19:35:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:36:00 INFO - 'use_talos_json': True, 19:36:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:36:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:36:00 INFO - 'work_dir': 'build'} 19:36:00 INFO - ##### 19:36:00 INFO - ##### Running clobber step. 19:36:00 INFO - ##### 19:36:00 INFO - Running pre-action listener: _resource_record_pre_action 19:36:00 INFO - Running main action method: clobber 19:36:00 INFO - rmtree: /builds/slave/test/build 19:36:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:36:02 INFO - Running post-action listener: _resource_record_post_action 19:36:02 INFO - ##### 19:36:02 INFO - ##### Running read-buildbot-config step. 19:36:02 INFO - ##### 19:36:02 INFO - Running pre-action listener: _resource_record_pre_action 19:36:02 INFO - Running main action method: read_buildbot_config 19:36:02 INFO - Using buildbot properties: 19:36:02 INFO - { 19:36:02 INFO - "project": "", 19:36:02 INFO - "product": "firefox", 19:36:02 INFO - "script_repo_revision": "production", 19:36:02 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 19:36:02 INFO - "repository": "", 19:36:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 19:36:02 INFO - "buildid": "20160325144302", 19:36:02 INFO - "pgo_build": "False", 19:36:02 INFO - "basedir": "/builds/slave/test", 19:36:02 INFO - "buildnumber": 243, 19:36:02 INFO - "slavename": "t-yosemite-r7-0178", 19:36:02 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 19:36:02 INFO - "platform": "yosemite_r7", 19:36:02 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 19:36:02 INFO - "branch": "mozilla-aurora", 19:36:02 INFO - "repo_path": "releases/mozilla-aurora", 19:36:02 INFO - "revision": "5629a22932f74f3e2d647c3462c32191a791afed", 19:36:02 INFO - "stage_platform": "macosx64", 19:36:02 INFO - "builduid": "45444673fb3642f28fbcb96a55172248", 19:36:02 INFO - "slavebuilddir": "test" 19:36:02 INFO - } 19:36:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 19:36:02 INFO - Running post-action listener: _resource_record_post_action 19:36:02 INFO - ##### 19:36:02 INFO - ##### Running download-and-extract step. 19:36:02 INFO - ##### 19:36:02 INFO - Running pre-action listener: _resource_record_pre_action 19:36:02 INFO - Running main action method: download_and_extract 19:36:02 INFO - mkdir: /builds/slave/test/build/tests 19:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:02 INFO - https://queue.taskcluster.net/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 19:36:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 19:36:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 19:36:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 19:36:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 19:36:03 INFO - Downloaded 1277 bytes. 19:36:03 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 19:36:03 INFO - Using the following test package requirements: 19:36:03 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 19:36:03 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:36:03 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 19:36:03 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:36:03 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 19:36:03 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:36:03 INFO - u'jsshell-mac.zip'], 19:36:03 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:36:03 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 19:36:03 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 19:36:03 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:36:03 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 19:36:03 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:36:03 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 19:36:03 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:36:03 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 19:36:03 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 19:36:03 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:36:03 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 19:36:03 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 19:36:03 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:36:03 INFO - https://queue.taskcluster.net/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:36:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 19:36:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 19:36:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 19:36:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:36:04 INFO - Downloaded 17869557 bytes. 19:36:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:36:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:36:07 INFO - Return code: 0 19:36:07 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 19:36:07 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:36:07 INFO - https://queue.taskcluster.net/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:36:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 19:36:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 19:36:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 19:36:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:36:08 INFO - Downloaded 17869557 bytes. 19:36:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:36:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:36:12 INFO - Return code: 0 19:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:12 INFO - https://queue.taskcluster.net/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:36:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 19:36:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 19:36:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 19:36:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 19:36:13 INFO - Downloaded 10845161 bytes. 19:36:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:36:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 19:36:13 INFO - Return code: 0 19:36: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:36:13 INFO - https://queue.taskcluster.net/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 19:36:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 19:36:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 19:36:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 19:36:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 19:36:17 INFO - Downloaded 114976549 bytes. 19:36:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 19:36:17 INFO - mkdir: /builds/slave/test/properties 19:36:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:36:17 INFO - Writing to file /builds/slave/test/properties/build_url 19:36:17 INFO - Contents: 19:36:17 INFO - build_url:https://queue.taskcluster.net/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 19:36:18 INFO - Running post-action listener: _resource_record_post_action 19:36:18 INFO - Running post-action listener: set_extra_try_arguments 19:36:18 INFO - ##### 19:36:18 INFO - ##### Running populate-webroot step. 19:36:18 INFO - ##### 19:36:18 INFO - Running pre-action listener: _resource_record_pre_action 19:36:18 INFO - Running main action method: populate_webroot 19:36:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:36:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:36:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:36:18 INFO - '--tppagecycles', 19:36:18 INFO - '7'], 19:36:18 INFO - 'tests': ['tsvgm']}}, 19:36:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:36:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:36:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:36:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:36:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:36:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:36:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:36:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:18 INFO - 'talos_options': ['--e10s'], 19:36:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:36:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:18 INFO - 'tests': ['damp', 'tps']}, 19:36:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:18 INFO - 'talos_options': ['--e10s'], 19:36:18 INFO - 'tests': ['damp', 'tps']}, 19:36:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:36:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:36:18 INFO - 'other': {'tests': ['a11yr', 19:36:18 INFO - 'ts_paint', 19:36:18 INFO - 'tpaint', 19:36:18 INFO - 'sessionrestore', 19:36:18 INFO - 'sessionrestore_no_auto_restore', 19:36:18 INFO - 'tabpaint']}, 19:36:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:36:18 INFO - 'tests': ['a11yr', 19:36:18 INFO - 'ts_paint', 19:36:18 INFO - 'tpaint', 19:36:18 INFO - 'sessionrestore', 19:36:18 INFO - 'sessionrestore_no_auto_restore', 19:36:18 INFO - 'tabpaint']}, 19:36:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:36:18 INFO - 'tests': ['a11yr', 19:36:18 INFO - 'ts_paint', 19:36:18 INFO - 'tpaint', 19:36:18 INFO - 'sessionrestore', 19:36:18 INFO - 'sessionrestore_no_auto_restore', 19:36:18 INFO - 'tabpaint']}, 19:36:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:36:18 INFO - 'tests': ['a11yr', 19:36:18 INFO - 'ts_paint', 19:36:18 INFO - 'tpaint', 19:36:18 INFO - 'sessionrestore', 19:36:18 INFO - 'sessionrestore_no_auto_restore', 19:36:18 INFO - 'tabpaint']}, 19:36:18 INFO - 'other_l64': {'tests': ['a11yr', 19:36:18 INFO - 'ts_paint', 19:36:18 INFO - 'tpaint', 19:36:18 INFO - 'sessionrestore', 19:36:18 INFO - 'sessionrestore_no_auto_restore', 19:36:18 INFO - 'tabpaint']}, 19:36:18 INFO - 'other_nol64': {'tests': ['a11yr', 19:36:18 INFO - 'ts_paint', 19:36:18 INFO - 'tpaint', 19:36:18 INFO - 'sessionrestore', 19:36:18 INFO - 'sessionrestore_no_auto_restore', 19:36:18 INFO - 'tabpaint']}, 19:36:18 INFO - 'svgr': {'tests': ['tsvgx', 19:36:18 INFO - 'tsvgr_opacity', 19:36:18 INFO - 'tart', 19:36:18 INFO - 'tscrollx', 19:36:18 INFO - 'cart']}, 19:36:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:36:18 INFO - 'tests': ['tsvgx', 19:36:18 INFO - 'tsvgr_opacity', 19:36:18 INFO - 'tart', 19:36:18 INFO - 'tscrollx', 19:36:18 INFO - 'cart']}, 19:36:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:18 INFO - 'tests': ['tp5o']}, 19:36:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:18 INFO - 'talos_options': ['--e10s'], 19:36:18 INFO - 'tests': ['tp5o']}, 19:36:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:18 INFO - 'talos_options': ['--xperf_path', 19:36:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:36:18 INFO - 'tests': ['tp5n']}, 19:36:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:18 INFO - 'talos_options': ['--e10s', 19:36:18 INFO - '--xperf_path', 19:36:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:36:18 INFO - 'tests': ['tp5n']}}, 19:36:18 INFO - 'talos.zip': {'path': '', 19:36:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:36:18 INFO - Running post-action listener: _resource_record_post_action 19:36:18 INFO - ##### 19:36:18 INFO - ##### Running create-virtualenv step. 19:36:18 INFO - ##### 19:36:18 INFO - Running pre-action listener: _resource_record_pre_action 19:36:18 INFO - Running main action method: create_virtualenv 19:36:18 INFO - Creating virtualenv /builds/slave/test/build/venv 19:36:18 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:36:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:36:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:36:19 INFO - Using real prefix '/tools/python27' 19:36:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:36:19 INFO - Installing distribute.............................................................................................................................................................................................done. 19:36:22 INFO - Installing pip.................done. 19:36:22 INFO - Return code: 0 19:36:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:36:22 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:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:22 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:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:22 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 0x1051f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051f94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4bbf6cc80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105096d30>, '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 0x104efadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10508db20>, '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.d4lId5Ruwh/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.kmZWM5DSaZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:36:22 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:36:22 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:36:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d4lId5Ruwh/Render', 19:36:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:22 INFO - 'HOME': '/Users/cltbld', 19:36:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:22 INFO - 'LOGNAME': 'cltbld', 19:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:22 INFO - 'MOZ_NO_REMOTE': '1', 19:36:22 INFO - 'NO_EM_RESTART': '1', 19:36:22 INFO - 'PAGER': '/bin/cat', 19:36:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:22 INFO - 'PWD': '/builds/slave/test', 19:36:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:22 INFO - 'SHELL': '/bin/bash', 19:36:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kmZWM5DSaZ/Listeners', 19:36:22 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 19:36:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:22 INFO - 'USER': 'cltbld', 19:36:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:22 INFO - 'XPC_FLAGS': '0x0', 19:36:22 INFO - 'XPC_SERVICE_NAME': '0', 19:36:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:22 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:36:22 INFO - Cleaning up... 19:36:22 INFO - Return code: 0 19:36:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:36:22 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:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:22 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:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:22 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 0x1051f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051f94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4bbf6cc80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105096d30>, '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 0x104efadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10508db20>, '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.d4lId5Ruwh/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.kmZWM5DSaZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:36:22 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:36:22 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:36:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d4lId5Ruwh/Render', 19:36:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:22 INFO - 'HOME': '/Users/cltbld', 19:36:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:22 INFO - 'LOGNAME': 'cltbld', 19:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:22 INFO - 'MOZ_NO_REMOTE': '1', 19:36:22 INFO - 'NO_EM_RESTART': '1', 19:36:22 INFO - 'PAGER': '/bin/cat', 19:36:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:22 INFO - 'PWD': '/builds/slave/test', 19:36:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:22 INFO - 'SHELL': '/bin/bash', 19:36:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kmZWM5DSaZ/Listeners', 19:36:22 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 19:36:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:22 INFO - 'USER': 'cltbld', 19:36:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:22 INFO - 'XPC_FLAGS': '0x0', 19:36:22 INFO - 'XPC_SERVICE_NAME': '0', 19:36:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:23 INFO - Downloading/unpacking psutil>=0.7.1 19:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:36:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:36:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:36:25 INFO - Installing collected packages: psutil 19:36:25 INFO - Running setup.py install for psutil 19:36:25 INFO - building 'psutil._psutil_osx' extension 19:36:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 19:36:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 19:36:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 19:36:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 19:36:26 INFO - building 'psutil._psutil_posix' extension 19:36:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 19:36:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:36:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:36:26 INFO - ^ 19:36:26 INFO - 1 warning generated. 19:36:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 19:36:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:36:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:36:26 INFO - Successfully installed psutil 19:36:26 INFO - Cleaning up... 19:36:27 INFO - Return code: 0 19:36:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:36:27 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:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:27 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:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:27 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 0x1051f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051f94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4bbf6cc80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105096d30>, '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 0x104efadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10508db20>, '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.d4lId5Ruwh/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.kmZWM5DSaZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:36:27 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:36:27 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:36:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d4lId5Ruwh/Render', 19:36:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:27 INFO - 'HOME': '/Users/cltbld', 19:36:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:27 INFO - 'LOGNAME': 'cltbld', 19:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:27 INFO - 'MOZ_NO_REMOTE': '1', 19:36:27 INFO - 'NO_EM_RESTART': '1', 19:36:27 INFO - 'PAGER': '/bin/cat', 19:36:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:27 INFO - 'PWD': '/builds/slave/test', 19:36:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:27 INFO - 'SHELL': '/bin/bash', 19:36:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kmZWM5DSaZ/Listeners', 19:36:27 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 19:36:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:27 INFO - 'USER': 'cltbld', 19:36:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:27 INFO - 'XPC_FLAGS': '0x0', 19:36:27 INFO - 'XPC_SERVICE_NAME': '0', 19:36:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:36:27 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:36:27 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:36:27 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:36:27 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:36:27 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:36:27 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:36:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:36:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:36:29 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:36:29 INFO - Installing collected packages: mozsystemmonitor 19:36:29 INFO - Running setup.py install for mozsystemmonitor 19:36:29 INFO - Successfully installed mozsystemmonitor 19:36:29 INFO - Cleaning up... 19:36:29 INFO - Return code: 0 19:36:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:29 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 0x1051f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051f94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4bbf6cc80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105096d30>, '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 0x104efadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10508db20>, '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.d4lId5Ruwh/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.kmZWM5DSaZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:36:29 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:36:29 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:36:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d4lId5Ruwh/Render', 19:36:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:29 INFO - 'HOME': '/Users/cltbld', 19:36:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:29 INFO - 'LOGNAME': 'cltbld', 19:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:29 INFO - 'MOZ_NO_REMOTE': '1', 19:36:29 INFO - 'NO_EM_RESTART': '1', 19:36:29 INFO - 'PAGER': '/bin/cat', 19:36:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:29 INFO - 'PWD': '/builds/slave/test', 19:36:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:29 INFO - 'SHELL': '/bin/bash', 19:36:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kmZWM5DSaZ/Listeners', 19:36:29 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 19:36:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:29 INFO - 'USER': 'cltbld', 19:36:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:29 INFO - 'XPC_FLAGS': '0x0', 19:36:29 INFO - 'XPC_SERVICE_NAME': '0', 19:36:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:30 INFO - Downloading/unpacking blobuploader==1.2.4 19:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:32 INFO - Downloading blobuploader-1.2.4.tar.gz 19:36:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:36:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:36:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:36:33 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:36:33 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:36:33 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:36:33 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:36:33 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:36:33 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:36:33 INFO - Downloading docopt-0.6.1.tar.gz 19:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:36:33 INFO - Installing collected packages: blobuploader, requests, docopt 19:36:33 INFO - Running setup.py install for blobuploader 19:36:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:36:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:36:33 INFO - Running setup.py install for requests 19:36:34 INFO - Running setup.py install for docopt 19:36:34 INFO - Successfully installed blobuploader requests docopt 19:36:34 INFO - Cleaning up... 19:36:34 INFO - Return code: 0 19:36:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:34 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 0x1051f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051f94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4bbf6cc80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105096d30>, '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 0x104efadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10508db20>, '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.d4lId5Ruwh/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.kmZWM5DSaZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:36:34 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:36:34 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:36:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d4lId5Ruwh/Render', 19:36:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:34 INFO - 'HOME': '/Users/cltbld', 19:36:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:34 INFO - 'LOGNAME': 'cltbld', 19:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:34 INFO - 'MOZ_NO_REMOTE': '1', 19:36:34 INFO - 'NO_EM_RESTART': '1', 19:36:34 INFO - 'PAGER': '/bin/cat', 19:36:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:34 INFO - 'PWD': '/builds/slave/test', 19:36:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:34 INFO - 'SHELL': '/bin/bash', 19:36:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kmZWM5DSaZ/Listeners', 19:36:34 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 19:36:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:34 INFO - 'USER': 'cltbld', 19:36:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:34 INFO - 'XPC_FLAGS': '0x0', 19:36:34 INFO - 'XPC_SERVICE_NAME': '0', 19:36:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:36:34 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-zPah_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:36:35 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-xiB_ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:36:35 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-17ZCtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:36:35 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-TDw3e2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:36:35 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-PCx_6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:36:35 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-ZmXZpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:36:35 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-F8RXmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:36:35 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Mu3AvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:36:35 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-9bKI0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:36:35 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-azxQOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:36:35 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-JTLnIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:36:36 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-n8Ma0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:36:36 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-5fpBrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:36:36 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-a2OeEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:36 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-BuDOJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:36:36 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-mTsNiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:36:36 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-lKYdEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:36:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:36:36 INFO - Running setup.py install for manifestparser 19:36:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:36:36 INFO - Running setup.py install for mozcrash 19:36:36 INFO - Running setup.py install for mozdebug 19:36:37 INFO - Running setup.py install for mozdevice 19:36:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:36:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:36:37 INFO - Running setup.py install for mozfile 19:36:37 INFO - Running setup.py install for mozhttpd 19:36:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:36:37 INFO - Running setup.py install for mozinfo 19:36:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:36:37 INFO - Running setup.py install for mozInstall 19:36:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:36:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:36:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:36:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:36:37 INFO - Running setup.py install for mozleak 19:36:37 INFO - Running setup.py install for mozlog 19:36:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:36:38 INFO - Running setup.py install for moznetwork 19:36:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:36:38 INFO - Running setup.py install for mozprocess 19:36:38 INFO - Running setup.py install for mozprofile 19:36:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:36:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:36:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:36:38 INFO - Running setup.py install for mozrunner 19:36:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:36:38 INFO - Running setup.py install for mozscreenshot 19:36:38 INFO - Running setup.py install for moztest 19:36:39 INFO - Running setup.py install for mozversion 19:36:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:36:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:36:39 INFO - Cleaning up... 19:36:39 INFO - Return code: 0 19:36:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:39 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 0x1051f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051f94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4bbf6cc80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105096d30>, '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 0x104efadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10508db20>, '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.d4lId5Ruwh/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.kmZWM5DSaZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:36:39 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:36:39 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:36:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d4lId5Ruwh/Render', 19:36:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:39 INFO - 'HOME': '/Users/cltbld', 19:36:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:39 INFO - 'LOGNAME': 'cltbld', 19:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:39 INFO - 'MOZ_NO_REMOTE': '1', 19:36:39 INFO - 'NO_EM_RESTART': '1', 19:36:39 INFO - 'PAGER': '/bin/cat', 19:36:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:39 INFO - 'PWD': '/builds/slave/test', 19:36:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:39 INFO - 'SHELL': '/bin/bash', 19:36:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kmZWM5DSaZ/Listeners', 19:36:39 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 19:36:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:39 INFO - 'USER': 'cltbld', 19:36:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:39 INFO - 'XPC_FLAGS': '0x0', 19:36:39 INFO - 'XPC_SERVICE_NAME': '0', 19:36:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:36:39 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-k5uYGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:36:39 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:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:36:39 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-9vIH7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:36:39 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:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:36:39 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-e32TdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:36:39 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:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:36:39 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-PsOwSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:36:39 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:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:36:39 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-WOCRho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:36:40 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:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:36:40 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-ET9Kca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:36:40 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:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:36:40 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-0V3WgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:36:40 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:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:36:40 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-zCI2fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:36:40 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:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:36:40 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-i5rIic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:36:40 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:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:36:40 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-SIbccR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:36:40 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:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:36:40 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-WcNdTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:36:40 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:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:36:40 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-aoiCT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:36:40 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:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:36:40 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-24n6Qx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:36:40 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:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:36:40 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-XKDSb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:36:40 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:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:40 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-dPb9kQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:41 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:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:36:41 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-G4Gxu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:36:41 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:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:36:41 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-n0Dvqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:36:41 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:36:41 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:36:41 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:36:41 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:36:41 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:36:41 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:36:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:36: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:36: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:36: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:36: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:36: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:36: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:36:43 INFO - Downloading blessings-1.6.tar.gz 19:36:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:36:43 INFO - Installing collected packages: blessings 19:36:43 INFO - Running setup.py install for blessings 19:36:43 INFO - Successfully installed blessings 19:36:43 INFO - Cleaning up... 19:36:43 INFO - Return code: 0 19:36:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:36:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:36:44 INFO - Reading from file tmpfile_stdout 19:36:44 INFO - Current package versions: 19:36:44 INFO - blessings == 1.6 19:36:44 INFO - blobuploader == 1.2.4 19:36:44 INFO - docopt == 0.6.1 19:36:44 INFO - manifestparser == 1.1 19:36:44 INFO - mozInstall == 1.12 19:36:44 INFO - mozcrash == 0.17 19:36:44 INFO - mozdebug == 0.1 19:36:44 INFO - mozdevice == 0.48 19:36:44 INFO - mozfile == 1.2 19:36:44 INFO - mozhttpd == 0.7 19:36:44 INFO - mozinfo == 0.9 19:36:44 INFO - mozleak == 0.1 19:36:44 INFO - mozlog == 3.1 19:36:44 INFO - moznetwork == 0.27 19:36:44 INFO - mozprocess == 0.22 19:36:44 INFO - mozprofile == 0.28 19:36:44 INFO - mozrunner == 6.11 19:36:44 INFO - mozscreenshot == 0.1 19:36:44 INFO - mozsystemmonitor == 0.0 19:36:44 INFO - moztest == 0.7 19:36:44 INFO - mozversion == 1.4 19:36:44 INFO - psutil == 3.1.1 19:36:44 INFO - requests == 1.2.3 19:36:44 INFO - wsgiref == 0.1.2 19:36:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:44 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 0x1051f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051f94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4bbf6cc80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105096d30>, '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 0x104efadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10508db20>, '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.d4lId5Ruwh/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.kmZWM5DSaZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:36:44 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:36:44 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:36:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d4lId5Ruwh/Render', 19:36:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:44 INFO - 'HOME': '/Users/cltbld', 19:36:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:44 INFO - 'LOGNAME': 'cltbld', 19:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:44 INFO - 'MOZ_NO_REMOTE': '1', 19:36:44 INFO - 'NO_EM_RESTART': '1', 19:36:44 INFO - 'PAGER': '/bin/cat', 19:36:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:44 INFO - 'PWD': '/builds/slave/test', 19:36:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:44 INFO - 'SHELL': '/bin/bash', 19:36:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kmZWM5DSaZ/Listeners', 19:36:44 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 19:36:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:44 INFO - 'USER': 'cltbld', 19:36:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:44 INFO - 'XPC_FLAGS': '0x0', 19:36:44 INFO - 'XPC_SERVICE_NAME': '0', 19:36:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:44 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:36:44 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:36:44 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:36:44 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:36:44 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:36:44 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:36:44 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:36:44 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:36:44 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:36:44 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:36:44 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:36:44 INFO - Cleaning up... 19:36:44 INFO - Return code: 0 19:36:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1051f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051f94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4bbf6cc80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105096d30>, '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 0x104efadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10508db20>, '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.d4lId5Ruwh/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.kmZWM5DSaZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:36:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:36:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:36:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d4lId5Ruwh/Render', 19:36:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:44 INFO - 'HOME': '/Users/cltbld', 19:36:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:44 INFO - 'LOGNAME': 'cltbld', 19:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:44 INFO - 'MOZ_NO_REMOTE': '1', 19:36:44 INFO - 'NO_EM_RESTART': '1', 19:36:44 INFO - 'PAGER': '/bin/cat', 19:36:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:44 INFO - 'PWD': '/builds/slave/test', 19:36:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:44 INFO - 'SHELL': '/bin/bash', 19:36:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kmZWM5DSaZ/Listeners', 19:36:44 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 19:36:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:44 INFO - 'USER': 'cltbld', 19:36:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:44 INFO - 'XPC_FLAGS': '0x0', 19:36:44 INFO - 'XPC_SERVICE_NAME': '0', 19:36:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:44 INFO - Downloading/unpacking jsonschema 19:36: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:36: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:36: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:36: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:36: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:36: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:36:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:36:47 INFO - Downloading/unpacking functools32 (from jsonschema) 19:36: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:36: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:36: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:36: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:36: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:36: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:36:47 INFO - Downloading functools32-3.2.3-2.tar.gz 19:36:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:36:47 INFO - warning: no files found matching '*.txt' 19:36:47 INFO - no previously-included directories found matching 'build' 19:36:47 INFO - no previously-included directories found matching 'dist' 19:36:47 INFO - no previously-included directories found matching '.git*' 19:36:47 INFO - Installing collected packages: jsonschema, functools32 19:36:47 INFO - Running setup.py install for functools32 19:36:47 INFO - warning: no files found matching '*.txt' 19:36:47 INFO - no previously-included directories found matching 'build' 19:36:47 INFO - no previously-included directories found matching 'dist' 19:36:47 INFO - no previously-included directories found matching '.git*' 19:36:47 INFO - Successfully installed jsonschema functools32 19:36:47 INFO - Cleaning up... 19:36:47 INFO - Return code: 0 19:36:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:47 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 0x1051f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051f94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4bbf6cc80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105096d30>, '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 0x104efadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10508db20>, '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.d4lId5Ruwh/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.kmZWM5DSaZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:36:47 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:36:47 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:36:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d4lId5Ruwh/Render', 19:36:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:47 INFO - 'HOME': '/Users/cltbld', 19:36:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:47 INFO - 'LOGNAME': 'cltbld', 19:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:47 INFO - 'MOZ_NO_REMOTE': '1', 19:36:47 INFO - 'NO_EM_RESTART': '1', 19:36:47 INFO - 'PAGER': '/bin/cat', 19:36:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:48 INFO - 'PWD': '/builds/slave/test', 19:36:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:48 INFO - 'SHELL': '/bin/bash', 19:36:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kmZWM5DSaZ/Listeners', 19:36:48 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 19:36:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:48 INFO - 'USER': 'cltbld', 19:36:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:48 INFO - 'XPC_FLAGS': '0x0', 19:36:48 INFO - 'XPC_SERVICE_NAME': '0', 19:36:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:48 INFO - Downloading/unpacking flake8 19:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:36:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:36:50 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:36:50 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:36:50 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:36:50 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:36:50 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:36:50 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:36:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:36:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:36:50 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:36:50 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:36:50 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:36:50 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:36:50 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:36:50 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:36:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:36:51 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:36:51 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:36:51 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:36:51 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:36:51 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:36:51 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:36:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:36:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:36:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:36:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:36:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:36:51 INFO - no previously-included directories found matching 'docs/_build' 19:36:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:36:51 INFO - Running setup.py install for pep8 19:36:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:36:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:36:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:36:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:36:52 INFO - no previously-included directories found matching 'docs/_build' 19:36:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:36:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:36:52 INFO - Cleaning up... 19:36:52 INFO - Return code: 0 19:36:52 INFO - Running post-action listener: _resource_record_post_action 19:36:52 INFO - Running post-action listener: _start_resource_monitoring 19:36:52 INFO - Starting resource monitoring. 19:36:52 INFO - ##### 19:36:52 INFO - ##### Running install step. 19:36:52 INFO - ##### 19:36:52 INFO - Running pre-action listener: _resource_record_pre_action 19:36:52 INFO - Running main action method: install 19:36:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:36:52 INFO - Reading from file tmpfile_stdout 19:36:52 INFO - Detecting whether we're running mozinstall >=1.0... 19:36:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:36:52 INFO - Reading from file tmpfile_stdout 19:36:52 INFO - Output received: 19:36:52 INFO - Usage: mozinstall [options] installer 19:36:52 INFO - Options: 19:36:52 INFO - -h, --help show this help message and exit 19:36:52 INFO - -d DEST, --destination=DEST 19:36:52 INFO - Directory to install application into. [default: 19:36:52 INFO - "/builds/slave/test"] 19:36:52 INFO - --app=APP Application being installed. [default: firefox] 19:36:52 INFO - mkdir: /builds/slave/test/build/application 19:36:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 19:37:24 INFO - Reading from file tmpfile_stdout 19:37:24 INFO - Output received: 19:37:24 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 19:37:24 INFO - Running post-action listener: _resource_record_post_action 19:37:24 INFO - ##### 19:37:24 INFO - ##### Running run-tests step. 19:37:24 INFO - ##### 19:37:24 INFO - Running pre-action listener: _resource_record_pre_action 19:37:24 INFO - Running main action method: run_tests 19:37:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:37:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:37:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:37:24 INFO - 2016-03-25 19:37:24.469 screenresolution[1642:7503] starting screenresolution argv=screenresolution get 19:37:24 INFO - 2016-03-25 19:37:24.472 screenresolution[1642:7503] Display 0: 1600x1200x32@60 19:37:24 INFO - 2016-03-25 19:37:24.478 screenresolution[1643:7507] starting screenresolution argv=screenresolution list 19:37:24 INFO - Available Modes on Display 0 19:37:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:37:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:37:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:37:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:37:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:37:24 INFO - Intel Iris: 19:37:24 INFO - Chipset Model: Intel Iris 19:37:24 INFO - Type: GPU 19:37:24 INFO - Bus: Built-In 19:37:24 INFO - VRAM (Dynamic, Max): 1536 MB 19:37:24 INFO - Vendor: Intel (0x8086) 19:37:24 INFO - Device ID: 0x0a2e 19:37:24 INFO - Revision ID: 0x0009 19:37:24 INFO - Displays: 19:37:24 INFO - Display: 19:37:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:37:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:37:24 INFO - Display Serial Number: 1600x1200 60 19:37:24 INFO - Main Display: Yes 19:37:24 INFO - Mirror: Off 19:37:24 INFO - Online: Yes 19:37:24 INFO - Rotation: Supported 19:37:24 INFO - Return code: 0 19:37:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:37:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:37:24 INFO - Python 2.7.3 19:37:24 INFO - Return code: 0 19:37:24 INFO - grabbing minidump binary from tooltool 19:37: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:37:24 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 0x105096d30>, '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 0x104efadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10508db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:37:24 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:37:24 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:37:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:37:24 INFO - Return code: 0 19:37:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:37:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:37:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:37:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:37:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:37:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:37:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:37:25 INFO - Return code: 0 19:37:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0178', '--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:37:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0178 --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:37:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d4lId5Ruwh/Render', 19:37:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:25 INFO - 'HOME': '/Users/cltbld', 19:37:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:25 INFO - 'LOGNAME': 'cltbld', 19:37:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:37:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:37:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:25 INFO - 'MOZ_NO_REMOTE': '1', 19:37:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:37:25 INFO - 'NO_EM_RESTART': '1', 19:37:25 INFO - 'PAGER': '/bin/cat', 19:37:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:25 INFO - 'PWD': '/builds/slave/test', 19:37:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:37:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:25 INFO - 'SHELL': '/bin/bash', 19:37:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kmZWM5DSaZ/Listeners', 19:37:25 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 19:37:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:25 INFO - 'USER': 'cltbld', 19:37:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:25 INFO - 'XPC_FLAGS': '0x0', 19:37:25 INFO - 'XPC_SERVICE_NAME': '0', 19:37:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0178', '--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:37:26 INFO - mozversion application_buildid: 20160325144302 19:37:26 INFO - mozversion application_changeset: 5629a22932f74f3e2d647c3462c32191a791afed 19:37:26 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:37:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:37:26 INFO - mozversion application_name: Firefox 19:37:26 INFO - mozversion application_remotingname: firefox-dev 19:37:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:37:26 INFO - mozversion application_vendor: Mozilla 19:37:26 INFO - mozversion application_version: 47.0a2 19:37:26 INFO - mozversion platform_buildid: 20160325144302 19:37:26 INFO - mozversion platform_changeset: 5629a22932f74f3e2d647c3462c32191a791afed 19:37:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:37:26 INFO - mozversion platform_version: 47.0a2 19:37:26 INFO - using testdate: 1458959846 19:37:26 INFO - actual date: 1458959846 19:37:26 INFO - starting webserver on 'localhost:49277' 19:37:26 INFO - SUITE-START | Running 2 tests 19:37:26 INFO - TEST-START | dromaeo_css 19:37:26 INFO - operating with platform_type : mac_ 19:37:26 INFO - Initialising browser for dromaeo_css test... 19:37:26 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpEkCggh/profile http://localhost:49277/getInfo.html) 19:37:28 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 19:37:28 INFO - PROCESS | 1661 | colorDepth:24 19:37:28 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 19:37:28 INFO - PROCESS | 1661 | __metrics 19:37:28 INFO - PROCESS | 1661 | 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:37:28 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:37:29 INFO - TEST-INFO | 1661: exit 0 19:37:29 INFO - Browser initialized. 19:37:29 INFO - Running cycle 1/1 for dromaeo_css test... 19:37:29 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpEkCggh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:37:40 INFO - PROCESS | 1663 | RSS: Main: 210812928 19:37:40 INFO - PROCESS | 1663 | 19:38:31 INFO - PROCESS | 1663 | 1458959911753 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:40:41 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 19:40:42 INFO - PROCESS | 1663 | RSS: Main: 323604480 19:40:42 INFO - PROCESS | 1663 | 19:43:45 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 19:43:45 INFO - PROCESS | 1663 | RSS: Main: 346550272 19:43:45 INFO - PROCESS | 1663 | 19:46:47 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 19:46:48 INFO - PROCESS | 1663 | RSS: Main: 349560832 19:46:48 INFO - PROCESS | 1663 | 19:49:50 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 19:49:50 INFO - PROCESS | 1663 | RSS: Main: 305041408 19:49:50 INFO - PROCESS | 1663 | 19:52:54 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 19:52:54 INFO - PROCESS | 1663 | RSS: Main: 308752384 19:52:54 INFO - PROCESS | 1663 | 19:55:57 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 19:55:57 INFO - PROCESS | 1663 | RSS: Main: 356163584 19:55:57 INFO - PROCESS | 1663 | 19:55:57 INFO - PROCESS | 1663 | __start_tp_report 19:55:57 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 19:55:57 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 19:55:57 INFO - PROCESS | 1663 | |i|pagename|runs| 19:55:57 INFO - PROCESS | 1663 | |0;dojo.html;2886.2640026793165;3315.983420082901;3535.9823200884;3540.9468857967117;3592.2097138629492;5732.742026608802;5743.511801496873;5759.452851979056;5765.365809760923;5779.797707080248;5736.684482353469;5776.942230577693;5779.739911703973;5848;5855.677937713424;5154.123798954187;5207.557357624597;5243;5244.983481740215;5329.067413202674;5318.441563635821;5325.707086110262;5326.387465441466;5340.465953404668;5341;5254.106801843676;5297.708626025586;5320.14877619581;5348.598855085865;5350.063738845706;4565.863024109282;5208.828013696907;5356.38401583819;5362;5417.6207665463435;5060.721660308682;5248.632595718302;5249.107651699221;5262.184361423985;5276.657017293902;5681.517071048966;5690.089585666274;5710.514606258473;5719.227904232917;5731.197632331477;6122.693865306762;6269.937300626981;6273.6235825850135;6281.152044474029;6289;6165.907511387333;6201.9689901550655;6233.252009758858;6249.718762655646;6275.7489700411925;5921.348651648315;5927.881442371128;5932.881342373128;5941.910871336933;5951.2858456985;6175.660338681416;6182.876342473125;6317.431431171217;6322.114903913456;6323.9051414228825;6219.284782250099;6250.1874756281395;6250.718717657716;6267.96866015667;6270.623762574261;6272.3100458949475;6278.968605156945;6285.465735412449;6289.937100629027;6307.747690092345;6152.538559608047;6171.074338849208;6188.2883468400805;6245.875082498324;6280.214973128359;6245.6252624842655;6261.499080073583;6289.685515724195;6292.087647291209;6296.685165741695;4946.4064312282035;4952;4954.826581069718;4955.281484184845;4960.553550180501;3603.531540899666;4369.497507786582;4375.584319489643;4454.844080457168;4459.955400445954;5747.224124743107;5758.395368486333;5773.162891380726;5791.478766910914;5801.970990145022;6313.147725057151;6351.96824015877;6361.522885783585;6361.936380636134;6373.5857169283845;5662.377138514842;5732.541396688255;5751.597388182787;5751.741171647286;5830.096335068071;5374.328208973879;5411.242426060355;5418.4039755626845;5434.266374039533;5434.347878254634;6312.368763123743;6312.810615681445;6321.747130114836;6331.810045698637;6339.683015849281;6226.59527130735;6246.656433895998;6304.18045654062;6360.77737279193;6364.395382438661;5339.77185247403;6326.620402775849;6329.272133704499;6333.303336633059;6354.4598709108395;6278.152449419453;6287.654179020198;6307.558470907176;6315.5263355247625;6322.873542529215;5995.2206213192;6190.0714892764645;6257.09272155544;6301.40136687014;6343.016832390987;6042.667653279112;6060.151578779062;6062.484688801501;6062.575619706578;6102.4507794298725;5954.851128721816;5994.220751302477;6038.064100064497;6039.758409663565;6049.304330002106;4804.327394164749;4998.900021999612;5879.529637629065;5910;5911.083782013795;5017.874553136201;6175.505959523317;6193.597416167935;6196.318404975539;6222.066689996355;5876.265466816648;5993.041113421831;6076.422739839708;6076.574639775174;6094.299155597163 19:55:57 INFO - PROCESS | 1663 | |1;ext.html;467.7941705649512;582.3041465448788;583.9314055278837;629.962202267864;650.8145178624092;25652.358691032732;30103.397932041375;32802.899637545306;32886.50670239942;32941.67058329416;42563.935901602475;42902.141957160835;42929.7853510732;42930.57069429305;42962.78518607411;8862.33532485063;8883.46699198047;9508.09673081058;9713.417194968324;9738.367006144614;9793.020697930186;9976;9976.850347244797;9978.401295922231;9983.500824958759;9917.603295868194;9991.250656200778;10004.399736015863;10015.098641122298;10041.347312424705;9915.95042024789;9968.601255949754;9987.950060249725;9988.350757200758;9998.850017249784;9767.804643907153;9882.752931176707;9888.604455821758;9892.455914924749;9919.851202231972;43096.1380772386;43416.309613682875;43696;43778.562214377765;43791.56208437939;3224.451843186664;3331;3399.83000849959;3437.5187473753695;3454.1882657575447;28844.711552884623;29036;30100.8494957526;30806.38387232265;31173.532397013838;2795.2313113893842;2812.5218712818664;2826.477101736165;2894.4789937811183;2925.093221101465;455652;457440.7127964372;458361;458808.70595646807;459490;47353;72981.27018729744;73342.63328683322;73431;73522.63238683772;47966.04067918692;48037;48076.5192348072;48197.03605927932;48265.27602085972;16706.081165536012;17053;17090.316387344617;17106.230219639896;17107.401240956755;13664.90680745538;13730;13764.93117534406;13765;13787.96590255735;13137.408816603276;14938.70122597542;15246.771298430533;15434.768478472832;15607.687846243012;5964.522838172936;6632.336766323426;6791.966040169767;6856;6873.965630171817;1036.5439206749006;1040.7190058684114;1041.7864337810731;1062.6493257225097;1106.8229083346625;28639;30134.698653013627;30585.847070764503;31140;31175.22061948424;1112.1103117505963;1192.797224471842;1197.4132674989194;1198.6763573835017;1240.8138779183196;15459.381624734884;15604.375824967101;15635.687286254211;15823.971441856242;15927;1022024;1026177;1028956;1028967;1032247;66497.00254496187;68275.63448731096;68356;68424;68653;1403.6280385697798;1422.4523558430078;1448.717500087473;1531.6477210241708;1634.329924730831;30103.3979320408;32647.673523264464;32995.67004329926;33103.50344744782;33563;57827.843443131744;58242;58351;58539.70730146322;58548.121778174216;324558;398694;405311;406215;407449;47562.76218618885;47682.523174769194;48594;49402;49604.75197624133;48847.75576122239;49920;49976.50023499864;50220.74889625528;50567;39010.02474938149;39184.608153918096;40851.71057039087;41088;41943.580564193966;39507.40738888861;39688.60311396849;40078.398824018244;40557;40986.590134098275;40660.3900941492;40673.79663101784;40868;41607;41628.79185604052;34407.31185376229;35081.824590877906;35514.537781370906;35693.82153089218;35775;23615.64576531388;26298.86850565735;26764.330891727863;26939.865300673373;27084.593731093657 19:55:57 INFO - PROCESS | 1663 | |2;jquery.html;384.39265959783546;385.24299750989303;385.41609461665576;394.31192568967157;394.3749157585227;16235.431759888406;20521.692174617394;20977.895110524427;21097.68353474699;21153.68269475955;9921.702348929544;11824.113191510629;12227.510899564008;12340.259584424919;12345.321007344592;4859.319695242669;5187.896242075156;5219.530242278194;5355.0896347621;5380.058489764295;5340.866478338034;5362.4637536246455;5376.596755243372;5393.7572809223675;5423.620346575742;5181.637285390024;5332.973335133319;5365.382980957201;5376.435474275204;5408.4591540845995;5290.814821481268;5308.893822123555;5332.33345831771;5342.572594192456;5349.7057661828585;4996.4503904570465;5155.200943853709;5163.7159956202395;5178.689278643255;5197.896042079137;13993.370298336498;14021.649458763612;14139.929300353433;14144.646383840383;19897.303594374127;2129.97761074685;2134.509062915538;2197.7802219777896;2357.634566642173;2693.4478431921407;8767.21095101444;10819.459027048695;12125.636230913087;13958.790618140736;15800.446984355607;1745.6246906914948;1804.3414153833887;1830.478313680608;1830.7345434911997;1842.3178122104339;114443.42778286138;117314;117388.41305793416;118372;118752;9848.50757462124;11901.464434100486;11942.820857687142;11977.940110299392;12047.819282710767;14634.634134146732;14735.705285894437;14750.778738318933;14775.039622424509;14800;8767.605457754416;8999.505027223566;9023.503707296162;9112.453252804853;9117.407368521024;9186.81626367469;9211.40125891815;9235.907640923504;9313.813723725487;9325.393849399767;4585;4655.208614535537;4667.416572928384;4697.989932164533;4709.1994360958715;1914.1864707499535;1945.8929758863114;1970.1528342812442;1977.16958877269;2001.5796682696796;864.9048604653483;882.2456799436518;985.5663508056432;992.593036854886;1059.2955684469741;19786.802131978784;20758.48103797387;20795.85622790731;20875.26936557213;20989.58020839605;1006.3207335048813;1015.1117771949545;1019.2966852871494;1030.1810061001522;1034.4827586206898;10840.78318433627;11162;11186.38474883873;11343.319400835977;11346;630634;663029;668632;677147;681966;109397.45301273443;110141.89858101477;111927;112169;117567;1050.0706874416044;1051.8369652703843;1067.2689207892618;1068.5725709716176;1071.2875937501474;15585.766213507033;18400.539986500444;18418.263269469073;18748.437546873614;18894;51376;58284;59107;59327;61196.38803611907;74290;76318;76319;78500;78697.60651196707;11894.762104758029;12090.455929483018;12333.876661233273;12361;12386.132970691964;13844.10013349129;13882.652933676334;14038;14143.929280353945;14361.425542978164;9894;11874.050075993728;11906.642800715992;12071.939640301742;12275.324857132586;11697.532098715956;12026.939865300617;12056.939715301367;12253.326067066397;12257.632271031884;11771.882281177079;12063.336516491678;12176;12208.69478263015;12243.510259589517;12016.939915300367;12056.578019769617;12210.450529726362;12277.877221227673;12283.38583070825;12011.459484323052;12027.939860300643;12215.08386871006;12260.632181034583;12261.69345766363 19:55:57 INFO - PROCESS | 1663 | |3;mootools.html;1356.6811799227187;1583.6674298397338;1663.775390322307;1980.772211195713;2069.172331067574;8341.91658083419;8526;8540.231379175873;8550;8557.657693692261;8621.224089831914;8740.257078148365;8892.688755893545;8900.73297801067;8903.020667726545;2546.299767563921;2581.045013345065;2587.857667828269;2590.2488278399337;2595.1565741134114;2299.72403311602;2368.6802281692007;2476.8142389320783;2504.2236906559024;2575.9871200644066;2529.734377890323;2551.9234422967247;2577.742225777426;2587.741225877416;2591.1319707897783;2517.34549017255;2542.9745702543014;2544.70735865376;2551.9234422967247;2555.3483861615355;2501.187114187896;2501.9124330648524;2502.5370306493173;2502.8122890783266;2503.123906632664;9163.770905727344;9228.5847136879;9254.537273136384;9257.583408746623;9259.120383563552;4641.814327426899;5685.005124103265;5709.115087161496;5728.255326807488;5728.656280623176;3550.6626870447267;3579.94630080549;3685.4471829225563;3706.814659267053;3766.227923275722;1079.9136069114531;1086.5056399338282;1103.9503222355013;1110.439228189759;1114.938678372689;12357.196782209128;12370.690732731753;12376.938115309365;12395.566155184615;12402.25586464815;5092.8472145835685;5094.617903657167;5121.718305493234;5168.508991645787;5171.818986335536;10347;10428.843567346345;10431.321964072462;10431.634892778717;10472.790544189074;5729.169270455761;5741.45456181662;5744.798932037359;5750.338711048283;5755.510781583528;5014.84955451337;5171.095058364771;5174.197999310113;5174.43081261061;5176.378834539879;3844.1927195288745;4103.548609652996;4139.875803725893;4143.6685065194715;4180.1848639515;1290.387066143593;1351.7364113997874;1374.9037567370387;1375.559820857336;1376.9449222031008;1393.393873664959;1417.9007469477037;1420.6874487612708;1428.114568967247;1452.2230606625405;8430.747077587683;8596.140385961355;8652.610632521551;8654.87017694735;8683.2185103341;1238.5012340139142;1248.843894513186;1263.646179069862;1269.911106222574;1272.923624582528;6190.164327815777;6270.3416141305415;6296.055591661196;6300.338464461165;6320.4311611955145;10655.946720266504;11013.83479247812;11144.33134011962;11147;11190.216684832147;10398.272120951611;10876.401797901033;11084.390358530358;11160.330380177053;11180.720481987853;8501.489910605384;8541.53021583819;8581.528015959182;8620.094890036582;8626.870596941051;8224.300934420642;8265.049519305116;8292.12932642064;8335.166483351617;8374.706885258987;9368.484733339732;9689.176420004096;9732.902670973199;9793.755156121155;9844.261680373857;9073.954630226806;9282.582283797381;9325.813483730422;9425.57584908667;10134.138598219233;7653.88519172224;7741.961290193738;7763.92236077632;7840.294373506412;7841.255080767318;7485.588292643957;7732.652030658746;8342.416030877781;8361.916380836114;8425.915740842758;5907.49786268172;7407.407407407287;7508.699652013858;7516.549007059594;7663.195364486872;7297.197308295977;7336.853262934818;7358.668859901424;7430.44271679637;7500.62496875165;7878.566678832719;7926.286634202949;7933.048034235929;7933.484323518953;7937.841243174988;6938.375546200866;7089.7873063808165;7107.857842843217;7118.359347658736;7123.85752284941;7190.892136618059;7200.747973820891;7225.963870180615;7244.637768111679;7244.927550724636 19:55:57 INFO - PROCESS | 1663 | |4;prototype.html;330.8659992702955;337.8851190595197;341.6293321745906;342.417889587701;347.9739019573534;5334.653247538908;6522.467220203249;6547.443467305279;6567.54027218095;6606;5535.391106978229;6528;6530.96734516328;6535.150430444048;6543.2148142222995;4688.5311468853015;4817.614590832725;4833.250846118857;4911.214205727084;4977.900441991158;4249.596288352602;4432.246518091916;4898.020395920812;4910.803567857281;4938.9753051234875;4866.586340161073;4867.1482490564185;4886.389201349832;4891.997140586172;4903.583195428393;4622.768861556926;4728.574428301452;4852.927206091911;4869.123557759602;4869.732164730938;4125.360569111793;4152.937705934413;4160.83356665733;4163.146554956257;4164.12553363794;6206.875862482725;6221.315655277961;6224.844378890519;6260.561760676755;6269.686515674243;5740;5747.856303592402;5754.568407369464;5756.625819321731;5760.683162426065;6725.226598941135;6944.201416837078;6960.443164546824;6964.199117101548;6965.094537710116;4741.336212930192;4754.239321708545;4757.833475828329;4760.214564596838;4773.76131193439;7165.068541089677;7355.705771769123;7361.079865016873;7369.447291453109;7380.114386273628;4807.6394270429855;4812.51874812516;4815.927761083586;4819.662623616313;4820.204666230103;4882.609391248691;4887.755612219375;4894.657373983858;4895.482400455799;4909.386326709161;5697.173909783059;5718.942810571924;5725.370209276976;5734.483896449339;5736.42635736423;6691.732330706717;6934.583924964519;6938.028675985366;6942.028116063755;6942.409895158867;1673.21358961288;1709.5896984723825;1711.247051297425;1712.143928035982;1712.7174016287422;1065.4672663668166;1116.0792346314324;1123.966281011571;1147.208426185929;1152.948117334705;5229.372475302988;6387.680615969183;6397.040443933447;6419.871602568016;6424.550281480251;5850.795222167204;7186.820329491805;7192;7231.168415632164;7239.782806515813;5364.980653675789;6299.275583307886;6366.745330186834;6371.776987805497;6378.075179099004;3797.35444974355;3845.3655146901006;3846.3076646203394;3847.8653247136217;3849.846006159722;7368.489459660756;7632.885506717404;7680.3087722104165;7681;7686.154523002465;7524.209957954336;7595.354394876387;7595.5442673439775;7601.7719468416035;7616.0860696716745;7650.540967541965;7677.654505547263;7685.500442471333;7686.654100565376;7724.034495688039;7089;7309.305615966475;7335.963320183365;7341.119065712149;7350.926490735238;5870.442307980735;7138.107736532934;7204.747833825791;7222.349988501061;7232.783016509513;6594.77996570636;7627.847443051219;7634.580098094658;7640.936947024384;7653.349465295512;4620.145273124483;4665.346851440869;4670.065986802585;4674.252119660838;4677.041206552581;6980.022796808553;7274.127104747464;7274.6726397313305;7283.781486555412;7314.195438501654;5707.4577915098;6917.584944903322;6968.581885086911;6992.370686638227;7044.682989265598;5630.971845140748;6950.131233595801;6954.408875245661;6955.6869940851775;6970.442364610718;6817.42051925572;6823.147106611674;6829.180498340231;6839.076724642109;6844.28135045813;6749.358810912955;6949.826254343682;6970.546914450544;6980.511364204457;6986.441084713109;6626.370494802986;6725.260221375547;6751.898721519083;6895.75864844728;6913.170419549485 19:55:57 INFO - PROCESS | 1663 | |5;yui.html;734.562935053643;771.7761849063771;779.7855589712829;787.1302211056782;791.4815795653849;15062.39750409985;15156.39374425023;15322.00406973546;15349.769753453693;15363.3086511107;14262.786058209134;14339.354729037192;14352.354144063516;14355.856441435582;14366.20985845778;827.2678679368772;843.4348986179244;980.3578655980326;1009.8535712321709;1010.1817527802467;980.6714750558572;998.5855869814019;1004.6333088422709;1005.2912696548952;1005.6279176704629;1066.029912779371;1073.8926107389238;1078.6278733836814;1079.7462596289865;1083.5611577311163;852.2244757270885;866.2982983783093;1040.2302296300759;1068.978620427591;1069.2408390043079;715.4598278299902;786.2177133751896;788.7751990682627;796.1401686178913;796.5618909599697;15208.391664333414;15291.694166116615;15305.00517466361;15307.693846123126;15317.770233446507;12880;12888.80666789999;12951.87048129516;13137.540186093536;13169.209847409185;10075.496225188712;10121.392716437038;10160.441175735332;10183.032611901857;10332.638357657446;3542.36237477254;3615.7288203384587;3618.8009659468717;3696.9445458318146;3699.241655460651;82552.76170857441;82638;86439.56780216121;86901.56549217277;86924;9729.318947673595;9837.065478779505;9844.064813842673;9946.850797238047;10021.699349019542;21213.893930530558;23347.766522334558;23348;23351.883240583687;23369.83150842451;7657.893034343099;7676.80807979805;7703.807404814925;7791.922080779233;8084.676612935416;4152.730072545275;4163.376283249535;4177.979110104491;4297.462817147856;4466.642668586505;3678.6321367863;3721.1627383838418;3722.106694393326;3724.6647801697977;3726.4782930389765;646.9288378278386;656.212544946057;658.1904257762978;666.2804171494774;687.1788213085315;435.2014054210559;567.5743192605546;567.7047935073739;634.2895956528718;645.1548471502347;7748.535087894745;8412;8427;8437.40938134337;8452.197041281068;522.3627174846681;598.6019297167422;603.0622382195728;616.8642898562309;624.1854380034008;3316.3698897209933;3702.66675999156;3940.5074365704286;3998.9400158997637;4040.2525532775944;93700.72047478305;99666;102998.48500757598;103966.48016759868;103991;70579;79802;81293.99999999882;86832;87867.24265514653;73967.5206495867;75602;76485;76918;77745;7726.652300646597;7823.8435231293915;7943.500523970935;8019.5990200490905;8039.598020099089;49946.00107997892;50024;50100.498995009584;50445.24332135094;50863.58970270213;71125.28874711186;73462.63268683622;74759;75281;75872.48255034979;9817.410955342702;10147.695569132939;10280.640177594047;10316.896831031594;10340.431276279876;10942.452877355941;11168.050715689258;11371;11432.485538150637;11909.76180476403;10382.688519344432;10485.9475702621;10634.680959571226;10731.89268107309;10735.677929662123;10570.232279932456;10788.406637635006;10839.024487796136;10888.45557722095;10937.890621093688;10107.39355638664;10146.441945693057;10226.897731022595;10233.897661023295;10312.845307320245;7438;8794.824103517765;8843.159899809507;9005.234555062892;9022.548872556477;7794.6882124714375;8936.329775266751;8939.106089391009;8993.28053755711;9087.636494540144 19:55:57 INFO - PROCESS | 1663 | __end_tp_report 19:55:57 INFO - PROCESS | 1663 | __start_cc_report 19:55:57 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1010 19:55:57 INFO - PROCESS | 1663 | __end_cc_report 19:55:57 INFO - PROCESS | 1663 | __startTimestamp1458960957395__endTimestamp 19:55:57 INFO - PROCESS | 1663 | 19:55:57 INFO - PROCESS | 1663 | ------- Summary: start ------- 19:55:57 INFO - PROCESS | 1663 | Number of tests: 6 19:55:57 INFO - PROCESS | 1663 | 19:55:57 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5756.19 Median:5951.29 stddev:668.27 (11.2%) stddev-sans-first:631.25 19:55:57 INFO - PROCESS | 1663 | Values: 2886.3 3316.0 3536.0 3540.9 3592.2 5732.7 5743.5 5759.5 5765.4 5779.8 5736.7 5776.9 5779.7 5848.0 5855.7 5154.1 5207.6 5243.0 5245.0 5329.1 5318.4 5325.7 5326.4 5340.5 5341.0 5254.1 5297.7 5320.1 5348.6 5350.1 4565.9 5208.8 5356.4 5362.0 5417.6 5060.7 5248.6 5249.1 5262.2 5276.7 5681.5 5690.1 5710.5 5719.2 5731.2 6122.7 6269.9 6273.6 6281.2 6289.0 6165.9 6202.0 6233.3 6249.7 6275.7 5921.3 5927.9 5932.9 5941.9 5951.3 6175.7 6182.9 6317.4 6322.1 6323.9 6219.3 6250.2 6250.7 6268.0 6270.6 6272.3 6279.0 6285.5 6289.9 6307.7 6152.5 6171.1 6188.3 6245.9 6280.2 6245.6 6261.5 6289.7 6292.1 6296.7 4946.4 4952.0 4954.8 4955.3 4960.6 3603.5 4369.5 4375.6 4454.8 4460.0 5747.2 5758.4 5773.2 5791.5 5802.0 6313.1 6352.0 6361.5 6361.9 6373.6 5662.4 5732.5 5751.6 5751.7 5830.1 5374.3 5411.2 5418.4 5434.3 5434.3 6312.4 6312.8 6321.7 6331.8 6339.7 6226.6 6246.7 6304.2 6360.8 6364.4 5339.8 6326.6 6329.3 6333.3 6354.5 6278.2 6287.7 6307.6 6315.5 6322.9 5995.2 6190.1 6257.1 6301.4 6343.0 6042.7 6060.2 6062.5 6062.6 6102.5 5954.9 5994.2 6038.1 6039.8 6049.3 4804.3 4998.9 5879.5 5910.0 5911.1 5017.9 6175.5 6193.6 6196.3 6222.1 5876.3 5993.0 6076.4 6076.6 6094.3 19:55:57 INFO - PROCESS | 1663 | 19:55:57 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:75997.89 Median:222934.00 stddev:186538.89 (83.7%) stddev-sans-first:186975.98 19:55:57 INFO - PROCESS | 1663 | Values: 467.8 582.3 583.9 630.0 650.8 25652.4 30103.4 32802.9 32886.5 32941.7 42563.9 42902.1 42929.8 42930.6 42962.8 8862.3 8883.5 9508.1 9713.4 9738.4 9793.0 9976.0 9976.9 9978.4 9983.5 9917.6 9991.3 10004.4 10015.1 10041.3 9916.0 9968.6 9988.0 9988.4 9998.9 9767.8 9882.8 9888.6 9892.5 9919.9 43096.1 43416.3 43696.0 43778.6 43791.6 3224.5 3331.0 3399.8 3437.5 3454.2 28844.7 29036.0 30100.8 30806.4 31173.5 2795.2 2812.5 2826.5 2894.5 2925.1 455652.0 457440.7 458361.0 458808.7 459490.0 47353.0 72981.3 73342.6 73431.0 73522.6 47966.0 48037.0 48076.5 48197.0 48265.3 16706.1 17053.0 17090.3 17106.2 17107.4 13664.9 13730.0 13764.9 13765.0 13788.0 13137.4 14938.7 15246.8 15434.8 15607.7 5964.5 6632.3 6792.0 6856.0 6874.0 1036.5 1040.7 1041.8 1062.6 1106.8 28639.0 30134.7 30585.8 31140.0 31175.2 1112.1 1192.8 1197.4 1198.7 1240.8 15459.4 15604.4 15635.7 15824.0 15927.0 1022024.0 1026177.0 1028956.0 1028967.0 1032247.0 66497.0 68275.6 68356.0 68424.0 68653.0 1403.6 1422.5 1448.7 1531.6 1634.3 30103.4 32647.7 32995.7 33103.5 33563.0 57827.8 58242.0 58351.0 58539.7 58548.1 324558.0 398694.0 405311.0 406215.0 407449.0 47562.8 47682.5 48594.0 49402.0 49604.8 48847.8 49920.0 49976.5 50220.7 50567.0 39010.0 39184.6 40851.7 41088.0 41943.6 39507.4 39688.6 40078.4 40557.0 40986.6 40660.4 40673.8 40868.0 41607.0 41628.8 34407.3 35081.8 35514.5 35693.8 35775.0 23615.6 26298.9 26764.3 26939.9 27084.6 19:55:57 INFO - PROCESS | 1663 | 19:55:57 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:36360.55 Median:18821.22 stddev:110002.51 (584.5%) stddev-sans-first:110277.92 19:55:57 INFO - PROCESS | 1663 | Values: 384.4 385.2 385.4 394.3 394.4 16235.4 20521.7 20977.9 21097.7 21153.7 9921.7 11824.1 12227.5 12340.3 12345.3 4859.3 5187.9 5219.5 5355.1 5380.1 5340.9 5362.5 5376.6 5393.8 5423.6 5181.6 5333.0 5365.4 5376.4 5408.5 5290.8 5308.9 5332.3 5342.6 5349.7 4996.5 5155.2 5163.7 5178.7 5197.9 13993.4 14021.6 14139.9 14144.6 19897.3 2130.0 2134.5 2197.8 2357.6 2693.4 8767.2 10819.5 12125.6 13958.8 15800.4 1745.6 1804.3 1830.5 1830.7 1842.3 114443.4 117314.0 117388.4 118372.0 118752.0 9848.5 11901.5 11942.8 11977.9 12047.8 14634.6 14735.7 14750.8 14775.0 14800.0 8767.6 8999.5 9023.5 9112.5 9117.4 9186.8 9211.4 9235.9 9313.8 9325.4 4585.0 4655.2 4667.4 4698.0 4709.2 1914.2 1945.9 1970.2 1977.2 2001.6 864.9 882.2 985.6 992.6 1059.3 19786.8 20758.5 20795.9 20875.3 20989.6 1006.3 1015.1 1019.3 1030.2 1034.5 10840.8 11162.0 11186.4 11343.3 11346.0 630634.0 663029.0 668632.0 677147.0 681966.0 109397.5 110141.9 111927.0 112169.0 117567.0 1050.1 1051.8 1067.3 1068.6 1071.3 15585.8 18400.5 18418.3 18748.4 18894.0 51376.0 58284.0 59107.0 59327.0 61196.4 74290.0 76318.0 76319.0 78500.0 78697.6 11894.8 12090.5 12333.9 12361.0 12386.1 13844.1 13882.7 14038.0 14143.9 14361.4 9894.0 11874.1 11906.6 12071.9 12275.3 11697.5 12026.9 12056.9 12253.3 12257.6 11771.9 12063.3 12176.0 12208.7 12243.5 12016.9 12056.6 12210.5 12277.9 12283.4 12011.5 12027.9 12215.1 12260.6 12261.7 19:55:57 INFO - PROCESS | 1663 | 19:55:57 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:6211.29 Median:5175.40 stddev:3232.52 (62.5%) stddev-sans-first:3220.99 19:55:57 INFO - PROCESS | 1663 | Values: 1356.7 1583.7 1663.8 1980.8 2069.2 8341.9 8526.0 8540.2 8550.0 8557.7 8621.2 8740.3 8892.7 8900.7 8903.0 2546.3 2581.0 2587.9 2590.2 2595.2 2299.7 2368.7 2476.8 2504.2 2576.0 2529.7 2551.9 2577.7 2587.7 2591.1 2517.3 2543.0 2544.7 2551.9 2555.3 2501.2 2501.9 2502.5 2502.8 2503.1 9163.8 9228.6 9254.5 9257.6 9259.1 4641.8 5685.0 5709.1 5728.3 5728.7 3550.7 3579.9 3685.4 3706.8 3766.2 1079.9 1086.5 1104.0 1110.4 1114.9 12357.2 12370.7 12376.9 12395.6 12402.3 5092.8 5094.6 5121.7 5168.5 5171.8 10347.0 10428.8 10431.3 10431.6 10472.8 5729.2 5741.5 5744.8 5750.3 5755.5 5014.8 5171.1 5174.2 5174.4 5176.4 3844.2 4103.5 4139.9 4143.7 4180.2 1290.4 1351.7 1374.9 1375.6 1376.9 1393.4 1417.9 1420.7 1428.1 1452.2 8430.7 8596.1 8652.6 8654.9 8683.2 1238.5 1248.8 1263.6 1269.9 1272.9 6190.2 6270.3 6296.1 6300.3 6320.4 10655.9 11013.8 11144.3 11147.0 11190.2 10398.3 10876.4 11084.4 11160.3 11180.7 8501.5 8541.5 8581.5 8620.1 8626.9 8224.3 8265.0 8292.1 8335.2 8374.7 9368.5 9689.2 9732.9 9793.8 9844.3 9074.0 9282.6 9325.8 9425.6 10134.1 7653.9 7742.0 7763.9 7840.3 7841.3 7485.6 7732.7 8342.4 8361.9 8425.9 5907.5 7407.4 7508.7 7516.5 7663.2 7297.2 7336.9 7358.7 7430.4 7500.6 7878.6 7926.3 7933.0 7933.5 7937.8 6938.4 7089.8 7107.9 7118.4 7123.9 7190.9 7200.7 7226.0 7244.6 7244.9 19:55:57 INFO - PROCESS | 1663 | 19:55:57 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:5721.08 Median:6374.93 stddev:1796.20 (28.2%) stddev-sans-first:1755.08 19:55:57 INFO - PROCESS | 1663 | Values: 330.9 337.9 341.6 342.4 348.0 5334.7 6522.5 6547.4 6567.5 6606.0 5535.4 6528.0 6531.0 6535.2 6543.2 4688.5 4817.6 4833.3 4911.2 4977.9 4249.6 4432.2 4898.0 4910.8 4939.0 4866.6 4867.1 4886.4 4892.0 4903.6 4622.8 4728.6 4852.9 4869.1 4869.7 4125.4 4152.9 4160.8 4163.1 4164.1 6206.9 6221.3 6224.8 6260.6 6269.7 5740.0 5747.9 5754.6 5756.6 5760.7 6725.2 6944.2 6960.4 6964.2 6965.1 4741.3 4754.2 4757.8 4760.2 4773.8 7165.1 7355.7 7361.1 7369.4 7380.1 4807.6 4812.5 4815.9 4819.7 4820.2 4882.6 4887.8 4894.7 4895.5 4909.4 5697.2 5718.9 5725.4 5734.5 5736.4 6691.7 6934.6 6938.0 6942.0 6942.4 1673.2 1709.6 1711.2 1712.1 1712.7 1065.5 1116.1 1124.0 1147.2 1152.9 5229.4 6387.7 6397.0 6419.9 6424.6 5850.8 7186.8 7192.0 7231.2 7239.8 5365.0 6299.3 6366.7 6371.8 6378.1 3797.4 3845.4 3846.3 3847.9 3849.8 7368.5 7632.9 7680.3 7681.0 7686.2 7524.2 7595.4 7595.5 7601.8 7616.1 7650.5 7677.7 7685.5 7686.7 7724.0 7089.0 7309.3 7336.0 7341.1 7350.9 5870.4 7138.1 7204.7 7222.3 7232.8 6594.8 7627.8 7634.6 7640.9 7653.3 4620.1 4665.3 4670.1 4674.3 4677.0 6980.0 7274.1 7274.7 7283.8 7314.2 5707.5 6917.6 6968.6 6992.4 7044.7 5631.0 6950.1 6954.4 6955.7 6970.4 6817.4 6823.1 6829.2 6839.1 6844.3 6749.4 6949.8 6970.5 6980.5 6986.4 6626.4 6725.3 6751.9 6895.8 6913.2 19:55:57 INFO - PROCESS | 1663 | 19:55:57 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:19052.20 Median:2450.92 stddev:27652.50 (1128.2%) stddev-sans-first:27695.87 19:55:57 INFO - PROCESS | 1663 | Values: 734.6 771.8 779.8 787.1 791.5 15062.4 15156.4 15322.0 15349.8 15363.3 14262.8 14339.4 14352.4 14355.9 14366.2 827.3 843.4 980.4 1009.9 1010.2 980.7 998.6 1004.6 1005.3 1005.6 1066.0 1073.9 1078.6 1079.7 1083.6 852.2 866.3 1040.2 1069.0 1069.2 715.5 786.2 788.8 796.1 796.6 15208.4 15291.7 15305.0 15307.7 15317.8 12880.0 12888.8 12951.9 13137.5 13169.2 10075.5 10121.4 10160.4 10183.0 10332.6 3542.4 3615.7 3618.8 3696.9 3699.2 82552.8 82638.0 86439.6 86901.6 86924.0 9729.3 9837.1 9844.1 9946.9 10021.7 21213.9 23347.8 23348.0 23351.9 23369.8 7657.9 7676.8 7703.8 7791.9 8084.7 4152.7 4163.4 4178.0 4297.5 4466.6 3678.6 3721.2 3722.1 3724.7 3726.5 646.9 656.2 658.2 666.3 687.2 435.2 567.6 567.7 634.3 645.2 7748.5 8412.0 8427.0 8437.4 8452.2 522.4 598.6 603.1 616.9 624.2 3316.4 3702.7 3940.5 3998.9 4040.3 93700.7 99666.0 102998.5 103966.5 103991.0 70579.0 79802.0 81294.0 86832.0 87867.2 73967.5 75602.0 76485.0 76918.0 77745.0 7726.7 7823.8 7943.5 8019.6 8039.6 49946.0 50024.0 50100.5 50445.2 50863.6 71125.3 73462.6 74759.0 75281.0 75872.5 9817.4 10147.7 10280.6 10316.9 10340.4 10942.5 11168.1 11371.0 11432.5 11909.8 10382.7 10485.9 10634.7 10731.9 10735.7 10570.2 10788.4 10839.0 10888.5 10937.9 10107.4 10146.4 10226.9 10233.9 10312.8 7438.0 8794.8 8843.2 9005.2 9022.5 7794.7 8936.3 8939.1 8993.3 9087.6 19:55:57 INFO - PROCESS | 1663 | -------- Summary: end -------- 19:55:57 INFO - PROCESS | 1663 | 19:55:57 INFO - TEST-INFO | 1663: exit 0 19:55:57 INFO - TEST-OK | dromaeo_css | took 1111722ms 19:55:57 INFO - TEST-START | kraken 19:55:57 INFO - operating with platform_type : mac_ 19:55:57 INFO - Initialising browser for kraken test... 19:55:57 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpApFjS_/profile http://localhost:49277/getInfo.html) 19:55:59 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 19:55:59 INFO - PROCESS | 1673 | colorDepth:24 19:55:59 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 19:55:59 INFO - PROCESS | 1673 | __metrics 19:56:00 INFO - PROCESS | 1673 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:56:00 INFO - PROCESS | 1673 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:56:00 INFO - TEST-INFO | 1673: exit 0 19:56:00 INFO - Browser initialized. 19:56:00 INFO - Running cycle 1/1 for kraken test... 19:56:00 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpApFjS_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:56:12 INFO - PROCESS | 1675 | RSS: Main: 210673664 19:56:12 INFO - PROCESS | 1675 | 19:56:15 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 19:56:15 INFO - PROCESS | 1675 | RSS: Main: 265084928 19:56:15 INFO - PROCESS | 1675 | 19:56:18 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 19:56:19 INFO - PROCESS | 1675 | RSS: Main: 274391040 19:56:19 INFO - PROCESS | 1675 | 19:56:22 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 19:56:22 INFO - PROCESS | 1675 | RSS: Main: 264421376 19:56:22 INFO - PROCESS | 1675 | 19:56:24 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 19:56:25 INFO - PROCESS | 1675 | RSS: Main: 265793536 19:56:25 INFO - PROCESS | 1675 | 19:56:27 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:56:28 INFO - PROCESS | 1675 | RSS: Main: 266964992 19:56:28 INFO - PROCESS | 1675 | 19:56:30 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 19:56:31 INFO - PROCESS | 1675 | RSS: Main: 267300864 19:56:31 INFO - PROCESS | 1675 | 19:56:34 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 19:56:34 INFO - PROCESS | 1675 | RSS: Main: 267620352 19:56:34 INFO - PROCESS | 1675 | 19:56:37 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 19:56:38 INFO - PROCESS | 1675 | RSS: Main: 266801152 19:56:38 INFO - PROCESS | 1675 | 19:56:39 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:56:40 INFO - PROCESS | 1675 | RSS: Main: 301953024 19:56:40 INFO - PROCESS | 1675 | 19:56:42 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:56:42 INFO - PROCESS | 1675 | RSS: Main: 302936064 19:56:42 INFO - PROCESS | 1675 | 19:56:44 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:56:45 INFO - PROCESS | 1675 | RSS: Main: 307355648 19:56:45 INFO - PROCESS | 1675 | 19:56:48 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:56:48 INFO - PROCESS | 1675 | RSS: Main: 309026816 19:56:48 INFO - PROCESS | 1675 | 19:56:51 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:56:51 INFO - PROCESS | 1675 | RSS: Main: 309374976 19:56:51 INFO - PROCESS | 1675 | 19:56:53 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 19:56:53 INFO - PROCESS | 1675 | RSS: Main: 369561600 19:56:53 INFO - PROCESS | 1675 | 19:56:53 INFO - PROCESS | 1675 | __start_tp_report 19:56:53 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 19:56:53 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 19:56:53 INFO - PROCESS | 1675 | |i|pagename|runs| 19:56:53 INFO - PROCESS | 1675 | |0;ai-astar;112;112;110;110;110;117;170;164;110;109 19:56:53 INFO - PROCESS | 1675 | |1;audio-beat-detection;148;119;160;175;116;137;116;149;145;118 19:56:53 INFO - PROCESS | 1675 | |2;audio-dft;194;185;185;184;188;186;184;184;186;185 19:56:53 INFO - PROCESS | 1675 | |3;audio-fft;73;79;72;115;55;57;62;56;122;56 19:56:53 INFO - PROCESS | 1675 | |4;audio-oscillator;91;95;127;80;78;86;117;82;116;152 19:56:53 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;102;129;87;84;88;83;88;87;133;84 19:56:53 INFO - PROCESS | 1675 | |6;imaging-darkroom;93;92;93;93;99;92;91;92;92;92 19:56:53 INFO - PROCESS | 1675 | |7;imaging-desaturate;88;87;88;86;88;93;127;85;84;86 19:56:53 INFO - PROCESS | 1675 | |8;json-parse-financial;56;57;59;59;59;58;57;66;54;51 19:56:53 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;62;63;69;62;69;69;71;67;66;67 19:56:53 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;79;80;80;79;80;89;99;101;82;83 19:56:53 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;118;117;132;132;130;120;120;116;117;127 19:56:53 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;132;120;131;133;134;132;127;127;130;129 19:56:53 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;56;66;91;91;75;64;65;65;65;65 19:56:53 INFO - PROCESS | 1675 | __end_tp_report 19:56:53 INFO - PROCESS | 1675 | __start_cc_report 19:56:53 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1212 19:56:53 INFO - PROCESS | 1675 | __end_cc_report 19:56:53 INFO - PROCESS | 1675 | __startTimestamp1458961013608__endTimestamp 19:56:53 INFO - PROCESS | 1675 | 19:56:53 INFO - PROCESS | 1675 | ------- Summary: start ------- 19:56:53 INFO - PROCESS | 1675 | Number of tests: 14 19:56:53 INFO - PROCESS | 1675 | 19:56:53 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:122.40 Median:112.00 stddev:23.66 (21.1%) stddev-sans-first:24.79 19:56:53 INFO - PROCESS | 1675 | Values: 112.0 112.0 110.0 110.0 110.0 117.0 170.0 164.0 110.0 109.0 19:56:53 INFO - PROCESS | 1675 | 19:56:53 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:146.50 stddev:20.69 (14.1%) stddev-sans-first:21.64 19:56:53 INFO - PROCESS | 1675 | Values: 148.0 119.0 160.0 175.0 116.0 137.0 116.0 149.0 145.0 118.0 19:56:53 INFO - PROCESS | 1675 | 19:56:53 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:186.10 Median:185.50 stddev:3.03 (1.6%) stddev-sans-first:1.30 19:56:53 INFO - PROCESS | 1675 | Values: 194.0 185.0 185.0 184.0 188.0 186.0 184.0 184.0 186.0 185.0 19:56:53 INFO - PROCESS | 1675 | 19:56:53 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:74.70 Median:59.50 stddev:24.61 (41.4%) stddev-sans-first:26.10 19:56:53 INFO - PROCESS | 1675 | Values: 73.0 79.0 72.0 115.0 55.0 57.0 62.0 56.0 122.0 56.0 19:56:53 INFO - PROCESS | 1675 | 19:56:53 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:81.00 stddev:24.56 (30.3%) stddev-sans-first:25.71 19:56:53 INFO - PROCESS | 1675 | Values: 91.0 95.0 127.0 80.0 78.0 86.0 117.0 82.0 116.0 152.0 19:56:53 INFO - PROCESS | 1675 | 19:56:53 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:96.50 Median:85.50 stddev:18.97 (22.2%) stddev-sans-first:20.02 19:56:53 INFO - PROCESS | 1675 | Values: 102.0 129.0 87.0 84.0 88.0 83.0 88.0 87.0 133.0 84.0 19:56:53 INFO - PROCESS | 1675 | 19:56:53 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:92.50 stddev:2.23 (2.4%) stddev-sans-first:2.37 19:56:53 INFO - PROCESS | 1675 | Values: 93.0 92.0 93.0 93.0 99.0 92.0 91.0 92.0 92.0 92.0 19:56:53 INFO - PROCESS | 1675 | 19:56:53 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:91.20 Median:87.50 stddev:12.81 (14.6%) stddev-sans-first:13.54 19:56:53 INFO - PROCESS | 1675 | Values: 88.0 87.0 88.0 86.0 88.0 93.0 127.0 85.0 84.0 86.0 19:56:53 INFO - PROCESS | 1675 | 19:56:53 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.50 stddev:3.89 (6.7%) stddev-sans-first:4.09 19:56:53 INFO - PROCESS | 1675 | Values: 56.0 57.0 59.0 59.0 59.0 58.0 57.0 66.0 54.0 51.0 19:56:53 INFO - PROCESS | 1675 | 19:56:53 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:68.00 stddev:3.21 (4.7%) stddev-sans-first:2.96 19:56:53 INFO - PROCESS | 1675 | Values: 62.0 63.0 69.0 62.0 69.0 69.0 71.0 67.0 66.0 67.0 19:56:53 INFO - PROCESS | 1675 | 19:56:53 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:81.00 stddev:8.35 (10.3%) stddev-sans-first:8.55 19:56:53 INFO - PROCESS | 1675 | Values: 79.0 80.0 80.0 79.0 80.0 89.0 99.0 101.0 82.0 83.0 19:56:53 INFO - PROCESS | 1675 | 19:56:53 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:123.50 stddev:6.59 (5.3%) stddev-sans-first:6.75 19:56:53 INFO - PROCESS | 1675 | Values: 118.0 117.0 132.0 132.0 130.0 120.0 120.0 116.0 117.0 127.0 19:56:53 INFO - PROCESS | 1675 | 19:56:53 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:129.50 Median:131.50 stddev:4.09 (3.1%) stddev-sans-first:4.24 19:56:53 INFO - PROCESS | 1675 | Values: 132.0 120.0 131.0 133.0 134.0 132.0 127.0 127.0 130.0 129.0 19:56:53 INFO - PROCESS | 1675 | 19:56:53 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:65.50 stddev:11.80 (18.0%) stddev-sans-first:11.33 19:56:53 INFO - PROCESS | 1675 | Values: 56.0 66.0 91.0 91.0 75.0 64.0 65.0 65.0 65.0 65.0 19:56:53 INFO - PROCESS | 1675 | -------- Summary: end -------- 19:56:53 INFO - PROCESS | 1675 | 19:56:54 INFO - TEST-INFO | 1675: exit 0 19:56:54 INFO - TEST-OK | kraken | took 56404ms 19:56:54 INFO - SUITE-END | took 1168s 19:56:54 INFO - Completed test suite (00:19:28) 19:56:54 INFO - javascript benchmark 19:56:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2886.2640026793165, 3315.983420082901, 3535.9823200884, 3540.9468857967117, 3592.2097138629492, 5732.742026608802, 5743.511801496873, 5759.452851979056, 5765.365809760923, 5779.797707080248, 5736.684482353469, 5776.942230577693, 5779.739911703973, 5848.0, 5855.677937713424, 5154.123798954187, 5207.557357624597, 5243.0, 5244.983481740215, 5329.067413202674, 5318.441563635821, 5325.707086110262, 5326.387465441466, 5340.465953404668, 5341.0, 5254.106801843676, 5297.708626025586, 5320.14877619581, 5348.598855085865, 5350.063738845706, 4565.863024109282, 5208.828013696907, 5356.38401583819, 5362.0, 5417.6207665463435, 5060.721660308682, 5248.632595718302, 5249.107651699221, 5262.184361423985, 5276.657017293902, 5681.517071048966, 5690.089585666274, 5710.514606258473, 5719.227904232917, 5731.197632331477, 6122.693865306762, 6269.937300626981, 6273.6235825850135, 6281.152044474029, 6289.0, 6165.907511387333, 6201.9689901550655, 6233.252009758858, 6249.718762655646, 6275.7489700411925, 5921.348651648315, 5927.881442371128, 5932.881342373128, 5941.910871336933, 5951.2858456985, 6175.660338681416, 6182.876342473125, 6317.431431171217, 6322.114903913456, 6323.9051414228825, 6219.284782250099, 6250.1874756281395, 6250.718717657716, 6267.96866015667, 6270.623762574261, 6272.3100458949475, 6278.968605156945, 6285.465735412449, 6289.937100629027, 6307.747690092345, 6152.538559608047, 6171.074338849208, 6188.2883468400805, 6245.875082498324, 6280.214973128359, 6245.6252624842655, 6261.499080073583, 6289.685515724195, 6292.087647291209, 6296.685165741695, 4946.4064312282035, 4952.0, 4954.826581069718, 4955.281484184845, 4960.553550180501, 3603.531540899666, 4369.497507786582, 4375.584319489643, 4454.844080457168, 4459.955400445954, 5747.224124743107, 5758.395368486333, 5773.162891380726, 5791.478766910914, 5801.970990145022, 6313.147725057151, 6351.96824015877, 6361.522885783585, 6361.936380636134, 6373.5857169283845, 5662.377138514842, 5732.541396688255, 5751.597388182787, 5751.741171647286, 5830.096335068071, 5374.328208973879, 5411.242426060355, 5418.4039755626845, 5434.266374039533, 5434.347878254634, 6312.368763123743, 6312.810615681445, 6321.747130114836, 6331.810045698637, 6339.683015849281, 6226.59527130735, 6246.656433895998, 6304.18045654062, 6360.77737279193, 6364.395382438661, 5339.77185247403, 6326.620402775849, 6329.272133704499, 6333.303336633059, 6354.4598709108395, 6278.152449419453, 6287.654179020198, 6307.558470907176, 6315.5263355247625, 6322.873542529215, 5995.2206213192, 6190.0714892764645, 6257.09272155544, 6301.40136687014, 6343.016832390987, 6042.667653279112, 6060.151578779062, 6062.484688801501, 6062.575619706578, 6102.4507794298725, 5954.851128721816, 5994.220751302477, 6038.064100064497, 6039.758409663565, 6049.304330002106, 4804.327394164749, 4998.900021999612, 5879.529637629065, 5910.0, 5911.083782013795, 5017.874553136201, 6175.505959523317, 6193.597416167935, 6196.318404975539, 6222.066689996355, 5876.265466816648, 5993.041113421831, 6076.422739839708, 6076.574639775174, 6094.299155597163], "unit": "score", "name": "dojo.html", "value": 5713.096862261333}, {"lowerIsBetter": false, "replicates": [467.7941705649512, 582.3041465448788, 583.9314055278837, 629.962202267864, 650.8145178624092, 25652.358691032732, 30103.397932041375, 32802.899637545306, 32886.50670239942, 32941.67058329416, 42563.935901602475, 42902.141957160835, 42929.7853510732, 42930.57069429305, 42962.78518607411, 8862.33532485063, 8883.46699198047, 9508.09673081058, 9713.417194968324, 9738.367006144614, 9793.020697930186, 9976.0, 9976.850347244797, 9978.401295922231, 9983.500824958759, 9917.603295868194, 9991.250656200778, 10004.399736015863, 10015.098641122298, 10041.347312424705, 9915.95042024789, 9968.601255949754, 9987.950060249725, 9988.350757200758, 9998.850017249784, 9767.804643907153, 9882.752931176707, 9888.604455821758, 9892.455914924749, 9919.851202231972, 43096.1380772386, 43416.309613682875, 43696.0, 43778.562214377765, 43791.56208437939, 3224.451843186664, 3331.0, 3399.83000849959, 3437.5187473753695, 3454.1882657575447, 28844.711552884623, 29036.0, 30100.8494957526, 30806.38387232265, 31173.532397013838, 2795.2313113893842, 2812.5218712818664, 2826.477101736165, 2894.4789937811183, 2925.093221101465, 455652.0, 457440.7127964372, 458361.0, 458808.70595646807, 459490.0, 47353.0, 72981.27018729744, 73342.63328683322, 73431.0, 73522.63238683772, 47966.04067918692, 48037.0, 48076.5192348072, 48197.03605927932, 48265.27602085972, 16706.081165536012, 17053.0, 17090.316387344617, 17106.230219639896, 17107.401240956755, 13664.90680745538, 13730.0, 13764.93117534406, 13765.0, 13787.96590255735, 13137.408816603276, 14938.70122597542, 15246.771298430533, 15434.768478472832, 15607.687846243012, 5964.522838172936, 6632.336766323426, 6791.966040169767, 6856.0, 6873.965630171817, 1036.5439206749006, 1040.7190058684114, 1041.7864337810731, 1062.6493257225097, 1106.8229083346625, 28639.0, 30134.698653013627, 30585.847070764503, 31140.0, 31175.22061948424, 1112.1103117505963, 1192.797224471842, 1197.4132674989194, 1198.6763573835017, 1240.8138779183196, 15459.381624734884, 15604.375824967101, 15635.687286254211, 15823.971441856242, 15927.0, 1022024.0, 1026177.0, 1028956.0, 1028967.0, 1032247.0, 66497.00254496187, 68275.63448731096, 68356.0, 68424.0, 68653.0, 1403.6280385697798, 1422.4523558430078, 1448.717500087473, 1531.6477210241708, 1634.329924730831, 30103.3979320408, 32647.673523264464, 32995.67004329926, 33103.50344744782, 33563.0, 57827.843443131744, 58242.0, 58351.0, 58539.70730146322, 58548.121778174216, 324558.0, 398694.0, 405311.0, 406215.0, 407449.0, 47562.76218618885, 47682.523174769194, 48594.0, 49402.0, 49604.75197624133, 48847.75576122239, 49920.0, 49976.50023499864, 50220.74889625528, 50567.0, 39010.02474938149, 39184.608153918096, 40851.71057039087, 41088.0, 41943.580564193966, 39507.40738888861, 39688.60311396849, 40078.398824018244, 40557.0, 40986.590134098275, 40660.3900941492, 40673.79663101784, 40868.0, 41607.0, 41628.79185604052, 34407.31185376229, 35081.824590877906, 35514.537781370906, 35693.82153089218, 35775.0, 23615.64576531388, 26298.86850565735, 26764.330891727863, 26939.865300673373, 27084.593731093657], "unit": "score", "name": "ext.html", "value": 20629.575402590246}, {"lowerIsBetter": false, "replicates": [384.39265959783546, 385.24299750989303, 385.41609461665576, 394.31192568967157, 394.3749157585227, 16235.431759888406, 20521.692174617394, 20977.895110524427, 21097.68353474699, 21153.68269475955, 9921.702348929544, 11824.113191510629, 12227.510899564008, 12340.259584424919, 12345.321007344592, 4859.319695242669, 5187.896242075156, 5219.530242278194, 5355.0896347621, 5380.058489764295, 5340.866478338034, 5362.4637536246455, 5376.596755243372, 5393.7572809223675, 5423.620346575742, 5181.637285390024, 5332.973335133319, 5365.382980957201, 5376.435474275204, 5408.4591540845995, 5290.814821481268, 5308.893822123555, 5332.33345831771, 5342.572594192456, 5349.7057661828585, 4996.4503904570465, 5155.200943853709, 5163.7159956202395, 5178.689278643255, 5197.896042079137, 13993.370298336498, 14021.649458763612, 14139.929300353433, 14144.646383840383, 19897.303594374127, 2129.97761074685, 2134.509062915538, 2197.7802219777896, 2357.634566642173, 2693.4478431921407, 8767.21095101444, 10819.459027048695, 12125.636230913087, 13958.790618140736, 15800.446984355607, 1745.6246906914948, 1804.3414153833887, 1830.478313680608, 1830.7345434911997, 1842.3178122104339, 114443.42778286138, 117314.0, 117388.41305793416, 118372.0, 118752.0, 9848.50757462124, 11901.464434100486, 11942.820857687142, 11977.940110299392, 12047.819282710767, 14634.634134146732, 14735.705285894437, 14750.778738318933, 14775.039622424509, 14800.0, 8767.605457754416, 8999.505027223566, 9023.503707296162, 9112.453252804853, 9117.407368521024, 9186.81626367469, 9211.40125891815, 9235.907640923504, 9313.813723725487, 9325.393849399767, 4585.0, 4655.208614535537, 4667.416572928384, 4697.989932164533, 4709.1994360958715, 1914.1864707499535, 1945.8929758863114, 1970.1528342812442, 1977.16958877269, 2001.5796682696796, 864.9048604653483, 882.2456799436518, 985.5663508056432, 992.593036854886, 1059.2955684469741, 19786.802131978784, 20758.48103797387, 20795.85622790731, 20875.26936557213, 20989.58020839605, 1006.3207335048813, 1015.1117771949545, 1019.2966852871494, 1030.1810061001522, 1034.4827586206898, 10840.78318433627, 11162.0, 11186.38474883873, 11343.319400835977, 11346.0, 630634.0, 663029.0, 668632.0, 677147.0, 681966.0, 109397.45301273443, 110141.89858101477, 111927.0, 112169.0, 117567.0, 1050.0706874416044, 1051.8369652703843, 1067.2689207892618, 1068.5725709716176, 1071.2875937501474, 15585.766213507033, 18400.539986500444, 18418.263269469073, 18748.437546873614, 18894.0, 51376.0, 58284.0, 59107.0, 59327.0, 61196.38803611907, 74290.0, 76318.0, 76319.0, 78500.0, 78697.60651196707, 11894.762104758029, 12090.455929483018, 12333.876661233273, 12361.0, 12386.132970691964, 13844.10013349129, 13882.652933676334, 14038.0, 14143.929280353945, 14361.425542978164, 9894.0, 11874.050075993728, 11906.642800715992, 12071.939640301742, 12275.324857132586, 11697.532098715956, 12026.939865300617, 12056.939715301367, 12253.326067066397, 12257.632271031884, 11771.882281177079, 12063.336516491678, 12176.0, 12208.69478263015, 12243.510259589517, 12016.939915300367, 12056.578019769617, 12210.450529726362, 12277.877221227673, 12283.38583070825, 12011.459484323052, 12027.939860300643, 12215.08386871006, 12260.632181034583, 12261.69345766363], "unit": "score", "name": "jquery.html", "value": 9645.827369308025}, {"lowerIsBetter": false, "replicates": [1356.6811799227187, 1583.6674298397338, 1663.775390322307, 1980.772211195713, 2069.172331067574, 8341.91658083419, 8526.0, 8540.231379175873, 8550.0, 8557.657693692261, 8621.224089831914, 8740.257078148365, 8892.688755893545, 8900.73297801067, 8903.020667726545, 2546.299767563921, 2581.045013345065, 2587.857667828269, 2590.2488278399337, 2595.1565741134114, 2299.72403311602, 2368.6802281692007, 2476.8142389320783, 2504.2236906559024, 2575.9871200644066, 2529.734377890323, 2551.9234422967247, 2577.742225777426, 2587.741225877416, 2591.1319707897783, 2517.34549017255, 2542.9745702543014, 2544.70735865376, 2551.9234422967247, 2555.3483861615355, 2501.187114187896, 2501.9124330648524, 2502.5370306493173, 2502.8122890783266, 2503.123906632664, 9163.770905727344, 9228.5847136879, 9254.537273136384, 9257.583408746623, 9259.120383563552, 4641.814327426899, 5685.005124103265, 5709.115087161496, 5728.255326807488, 5728.656280623176, 3550.6626870447267, 3579.94630080549, 3685.4471829225563, 3706.814659267053, 3766.227923275722, 1079.9136069114531, 1086.5056399338282, 1103.9503222355013, 1110.439228189759, 1114.938678372689, 12357.196782209128, 12370.690732731753, 12376.938115309365, 12395.566155184615, 12402.25586464815, 5092.8472145835685, 5094.617903657167, 5121.718305493234, 5168.508991645787, 5171.818986335536, 10347.0, 10428.843567346345, 10431.321964072462, 10431.634892778717, 10472.790544189074, 5729.169270455761, 5741.45456181662, 5744.798932037359, 5750.338711048283, 5755.510781583528, 5014.84955451337, 5171.095058364771, 5174.197999310113, 5174.43081261061, 5176.378834539879, 3844.1927195288745, 4103.548609652996, 4139.875803725893, 4143.6685065194715, 4180.1848639515, 1290.387066143593, 1351.7364113997874, 1374.9037567370387, 1375.559820857336, 1376.9449222031008, 1393.393873664959, 1417.9007469477037, 1420.6874487612708, 1428.114568967247, 1452.2230606625405, 8430.747077587683, 8596.140385961355, 8652.610632521551, 8654.87017694735, 8683.2185103341, 1238.5012340139142, 1248.843894513186, 1263.646179069862, 1269.911106222574, 1272.923624582528, 6190.164327815777, 6270.3416141305415, 6296.055591661196, 6300.338464461165, 6320.4311611955145, 10655.946720266504, 11013.83479247812, 11144.33134011962, 11147.0, 11190.216684832147, 10398.272120951611, 10876.401797901033, 11084.390358530358, 11160.330380177053, 11180.720481987853, 8501.489910605384, 8541.53021583819, 8581.528015959182, 8620.094890036582, 8626.870596941051, 8224.300934420642, 8265.049519305116, 8292.12932642064, 8335.166483351617, 8374.706885258987, 9368.484733339732, 9689.176420004096, 9732.902670973199, 9793.755156121155, 9844.261680373857, 9073.954630226806, 9282.582283797381, 9325.813483730422, 9425.57584908667, 10134.138598219233, 7653.88519172224, 7741.961290193738, 7763.92236077632, 7840.294373506412, 7841.255080767318, 7485.588292643957, 7732.652030658746, 8342.416030877781, 8361.916380836114, 8425.915740842758, 5907.49786268172, 7407.407407407287, 7508.699652013858, 7516.549007059594, 7663.195364486872, 7297.197308295977, 7336.853262934818, 7358.668859901424, 7430.44271679637, 7500.62496875165, 7878.566678832719, 7926.286634202949, 7933.048034235929, 7933.484323518953, 7937.841243174988, 6938.375546200866, 7089.7873063808165, 7107.857842843217, 7118.359347658736, 7123.85752284941, 7190.892136618059, 7200.747973820891, 7225.963870180615, 7244.637768111679, 7244.927550724636], "unit": "score", "name": "mootools.html", "value": 5102.822241147262}, {"lowerIsBetter": false, "replicates": [330.8659992702955, 337.8851190595197, 341.6293321745906, 342.417889587701, 347.9739019573534, 5334.653247538908, 6522.467220203249, 6547.443467305279, 6567.54027218095, 6606.0, 5535.391106978229, 6528.0, 6530.96734516328, 6535.150430444048, 6543.2148142222995, 4688.5311468853015, 4817.614590832725, 4833.250846118857, 4911.214205727084, 4977.900441991158, 4249.596288352602, 4432.246518091916, 4898.020395920812, 4910.803567857281, 4938.9753051234875, 4866.586340161073, 4867.1482490564185, 4886.389201349832, 4891.997140586172, 4903.583195428393, 4622.768861556926, 4728.574428301452, 4852.927206091911, 4869.123557759602, 4869.732164730938, 4125.360569111793, 4152.937705934413, 4160.83356665733, 4163.146554956257, 4164.12553363794, 6206.875862482725, 6221.315655277961, 6224.844378890519, 6260.561760676755, 6269.686515674243, 5740.0, 5747.856303592402, 5754.568407369464, 5756.625819321731, 5760.683162426065, 6725.226598941135, 6944.201416837078, 6960.443164546824, 6964.199117101548, 6965.094537710116, 4741.336212930192, 4754.239321708545, 4757.833475828329, 4760.214564596838, 4773.76131193439, 7165.068541089677, 7355.705771769123, 7361.079865016873, 7369.447291453109, 7380.114386273628, 4807.6394270429855, 4812.51874812516, 4815.927761083586, 4819.662623616313, 4820.204666230103, 4882.609391248691, 4887.755612219375, 4894.657373983858, 4895.482400455799, 4909.386326709161, 5697.173909783059, 5718.942810571924, 5725.370209276976, 5734.483896449339, 5736.42635736423, 6691.732330706717, 6934.583924964519, 6938.028675985366, 6942.028116063755, 6942.409895158867, 1673.21358961288, 1709.5896984723825, 1711.247051297425, 1712.143928035982, 1712.7174016287422, 1065.4672663668166, 1116.0792346314324, 1123.966281011571, 1147.208426185929, 1152.948117334705, 5229.372475302988, 6387.680615969183, 6397.040443933447, 6419.871602568016, 6424.550281480251, 5850.795222167204, 7186.820329491805, 7192.0, 7231.168415632164, 7239.782806515813, 5364.980653675789, 6299.275583307886, 6366.745330186834, 6371.776987805497, 6378.075179099004, 3797.35444974355, 3845.3655146901006, 3846.3076646203394, 3847.8653247136217, 3849.846006159722, 7368.489459660756, 7632.885506717404, 7680.3087722104165, 7681.0, 7686.154523002465, 7524.209957954336, 7595.354394876387, 7595.5442673439775, 7601.7719468416035, 7616.0860696716745, 7650.540967541965, 7677.654505547263, 7685.500442471333, 7686.654100565376, 7724.034495688039, 7089.0, 7309.305615966475, 7335.963320183365, 7341.119065712149, 7350.926490735238, 5870.442307980735, 7138.107736532934, 7204.747833825791, 7222.349988501061, 7232.783016509513, 6594.77996570636, 7627.847443051219, 7634.580098094658, 7640.936947024384, 7653.349465295512, 4620.145273124483, 4665.346851440869, 4670.065986802585, 4674.252119660838, 4677.041206552581, 6980.022796808553, 7274.127104747464, 7274.6726397313305, 7283.781486555412, 7314.195438501654, 5707.4577915098, 6917.584944903322, 6968.581885086911, 6992.370686638227, 7044.682989265598, 5630.971845140748, 6950.131233595801, 6954.408875245661, 6955.6869940851775, 6970.442364610718, 6817.42051925572, 6823.147106611674, 6829.180498340231, 6839.076724642109, 6844.28135045813, 6749.358810912955, 6949.826254343682, 6970.546914450544, 6980.511364204457, 6986.441084713109, 6626.370494802986, 6725.260221375547, 6751.898721519083, 6895.75864844728, 6913.170419549485], "unit": "score", "name": "prototype.html", "value": 5134.530424532703}, {"lowerIsBetter": false, "replicates": [734.562935053643, 771.7761849063771, 779.7855589712829, 787.1302211056782, 791.4815795653849, 15062.39750409985, 15156.39374425023, 15322.00406973546, 15349.769753453693, 15363.3086511107, 14262.786058209134, 14339.354729037192, 14352.354144063516, 14355.856441435582, 14366.20985845778, 827.2678679368772, 843.4348986179244, 980.3578655980326, 1009.8535712321709, 1010.1817527802467, 980.6714750558572, 998.5855869814019, 1004.6333088422709, 1005.2912696548952, 1005.6279176704629, 1066.029912779371, 1073.8926107389238, 1078.6278733836814, 1079.7462596289865, 1083.5611577311163, 852.2244757270885, 866.2982983783093, 1040.2302296300759, 1068.978620427591, 1069.2408390043079, 715.4598278299902, 786.2177133751896, 788.7751990682627, 796.1401686178913, 796.5618909599697, 15208.391664333414, 15291.694166116615, 15305.00517466361, 15307.693846123126, 15317.770233446507, 12880.0, 12888.80666789999, 12951.87048129516, 13137.540186093536, 13169.209847409185, 10075.496225188712, 10121.392716437038, 10160.441175735332, 10183.032611901857, 10332.638357657446, 3542.36237477254, 3615.7288203384587, 3618.8009659468717, 3696.9445458318146, 3699.241655460651, 82552.76170857441, 82638.0, 86439.56780216121, 86901.56549217277, 86924.0, 9729.318947673595, 9837.065478779505, 9844.064813842673, 9946.850797238047, 10021.699349019542, 21213.893930530558, 23347.766522334558, 23348.0, 23351.883240583687, 23369.83150842451, 7657.893034343099, 7676.80807979805, 7703.807404814925, 7791.922080779233, 8084.676612935416, 4152.730072545275, 4163.376283249535, 4177.979110104491, 4297.462817147856, 4466.642668586505, 3678.6321367863, 3721.1627383838418, 3722.106694393326, 3724.6647801697977, 3726.4782930389765, 646.9288378278386, 656.212544946057, 658.1904257762978, 666.2804171494774, 687.1788213085315, 435.2014054210559, 567.5743192605546, 567.7047935073739, 634.2895956528718, 645.1548471502347, 7748.535087894745, 8412.0, 8427.0, 8437.40938134337, 8452.197041281068, 522.3627174846681, 598.6019297167422, 603.0622382195728, 616.8642898562309, 624.1854380034008, 3316.3698897209933, 3702.66675999156, 3940.5074365704286, 3998.9400158997637, 4040.2525532775944, 93700.72047478305, 99666.0, 102998.48500757598, 103966.48016759868, 103991.0, 70579.0, 79802.0, 81293.99999999882, 86832.0, 87867.24265514653, 73967.5206495867, 75602.0, 76485.0, 76918.0, 77745.0, 7726.652300646597, 7823.8435231293915, 7943.500523970935, 8019.5990200490905, 8039.598020099089, 49946.00107997892, 50024.0, 50100.498995009584, 50445.24332135094, 50863.58970270213, 71125.28874711186, 73462.63268683622, 74759.0, 75281.0, 75872.48255034979, 9817.410955342702, 10147.695569132939, 10280.640177594047, 10316.896831031594, 10340.431276279876, 10942.452877355941, 11168.050715689258, 11371.0, 11432.485538150637, 11909.76180476403, 10382.688519344432, 10485.9475702621, 10634.680959571226, 10731.89268107309, 10735.677929662123, 10570.232279932456, 10788.406637635006, 10839.024487796136, 10888.45557722095, 10937.890621093688, 10107.39355638664, 10146.441945693057, 10226.897731022595, 10233.897661023295, 10312.845307320245, 7438.0, 8794.824103517765, 8843.159899809507, 9005.234555062892, 9022.548872556477, 7794.6882124714375, 8936.329775266751, 8939.106089391009, 8993.28053755711, 9087.636494540144], "unit": "score", "name": "yui.html", "value": 7024.385506159428}], "name": "dromaeo_css", "value": 7705.060402140225}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 110.0, 110.0, 110.0, 117.0, 170.0, 164.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 122.4}, {"lowerIsBetter": true, "replicates": [148.0, 119.0, 160.0, 175.0, 116.0, 137.0, 116.0, 149.0, 145.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 138.3}, {"lowerIsBetter": true, "replicates": [194.0, 185.0, 185.0, 184.0, 188.0, 186.0, 184.0, 184.0, 186.0, 185.0], "unit": "score", "name": "audio-dft", "value": 186.1}, {"lowerIsBetter": true, "replicates": [73.0, 79.0, 72.0, 115.0, 55.0, 57.0, 62.0, 56.0, 122.0, 56.0], "unit": "score", "name": "audio-fft", "value": 74.7}, {"lowerIsBetter": true, "replicates": [91.0, 95.0, 127.0, 80.0, 78.0, 86.0, 117.0, 82.0, 116.0, 152.0], "unit": "score", "name": "audio-oscillator", "value": 102.4}, {"lowerIsBetter": true, "replicates": [102.0, 129.0, 87.0, 84.0, 88.0, 83.0, 88.0, 87.0, 133.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.5}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 93.0, 93.0, 99.0, 92.0, 91.0, 92.0, 92.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 92.9}, {"lowerIsBetter": true, "replicates": [88.0, 87.0, 88.0, 86.0, 88.0, 93.0, 127.0, 85.0, 84.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 91.2}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 59.0, 59.0, 59.0, 58.0, 57.0, 66.0, 54.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [62.0, 63.0, 69.0, 62.0, 69.0, 69.0, 71.0, 67.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.5}, {"lowerIsBetter": true, "replicates": [79.0, 80.0, 80.0, 79.0, 80.0, 89.0, 99.0, 101.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 132.0, 132.0, 130.0, 120.0, 120.0, 116.0, 117.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.9}, {"lowerIsBetter": true, "replicates": [132.0, 120.0, 131.0, 133.0, 134.0, 132.0, 127.0, 127.0, 130.0, 129.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 129.5}, {"lowerIsBetter": true, "replicates": [56.0, 66.0, 91.0, 91.0, 75.0, 64.0, 65.0, 65.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.3}], "name": "kraken", "value": 1436.5000000000002}]} 19:56:54 INFO - Return code: 0 19:56:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:56:54 INFO - # TBPL SUCCESS # 19:56:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:56:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:56:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:56:54 INFO - 2016-03-25 19:56:54.897 screenresolution[1679:9769] starting screenresolution argv=screenresolution get 19:56:54 INFO - 2016-03-25 19:56:54.899 screenresolution[1679:9769] Display 0: 1600x1200x32@60 19:56:54 INFO - 2016-03-25 19:56:54.905 screenresolution[1680:9772] starting screenresolution argv=screenresolution list 19:56:54 INFO - Available Modes on Display 0 19:56:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:56:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:56:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:56:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:56:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:56:55 INFO - Intel Iris: 19:56:55 INFO - Chipset Model: Intel Iris 19:56:55 INFO - Type: GPU 19:56:55 INFO - Bus: Built-In 19:56:55 INFO - VRAM (Dynamic, Max): 1536 MB 19:56:55 INFO - Vendor: Intel (0x8086) 19:56:55 INFO - Device ID: 0x0a2e 19:56:55 INFO - Revision ID: 0x0009 19:56:55 INFO - Displays: 19:56:55 INFO - Display: 19:56:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:56:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:56:55 INFO - Display Serial Number: 1600x1200 60 19:56:55 INFO - Main Display: Yes 19:56:55 INFO - Mirror: Off 19:56:55 INFO - Online: Yes 19:56:55 INFO - Rotation: Supported 19:56:55 INFO - Return code: 0 19:56:55 INFO - Running post-action listener: _resource_record_post_action 19:56:55 INFO - Running post-run listener: _resource_record_post_run 19:56:56 INFO - Total resource usage - Wall time: 1202s; CPU: 53.0%; Read bytes: 37475840; Write bytes: 662941184; Read time: 390; Write time: 2646 19:56:56 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 360319488; Write bytes: 353994240; Read time: 28297; Write time: 798 19:56:56 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 35636736; Write bytes: 298817536; Read time: 369; Write time: 1819 19:56:56 INFO - Running post-run listener: _upload_blobber_files 19:56:56 INFO - Blob upload gear active. 19:56:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:56:56 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 19:56:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:56:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:56:56 INFO - (blobuploader) - INFO - Open directory for files ... 19:56:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:56:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:56:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:56:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:56:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:56:57 INFO - (blobuploader) - INFO - Done attempting. 19:56:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:56:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:56:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:56:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:56:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:56:58 INFO - (blobuploader) - INFO - Done attempting. 19:56:58 INFO - (blobuploader) - INFO - Iteration through files over. 19:56:58 INFO - Return code: 0 19:56:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:56:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:56:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2e339a4c538fd3f15f54b6c24a3dd3c564014798b0ddb0c9a6a718a57c6f2a53c419981b3469a6e90635f16d6e8b0470f588c49909a0ff310003a1e07d001d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d12663ae10b2b9af8a752f95d0bd7c5013fb5492b86f87b65d003096a0c2ba9a4e3bd36e6b0fed89481d39cc1975764582433206db52facbbfa117b31d5d2ce"} 19:56:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:56:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:56:58 INFO - Contents: 19:56:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2e339a4c538fd3f15f54b6c24a3dd3c564014798b0ddb0c9a6a718a57c6f2a53c419981b3469a6e90635f16d6e8b0470f588c49909a0ff310003a1e07d001d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d12663ae10b2b9af8a752f95d0bd7c5013fb5492b86f87b65d003096a0c2ba9a4e3bd36e6b0fed89481d39cc1975764582433206db52facbbfa117b31d5d2ce"} 19:56:58 INFO - Running post-run listener: copy_logs_to_upload_dir 19:56:58 INFO - Copying logs to upload dir... 19:56:58 INFO - mkdir: /builds/slave/test/build/upload/logs 19:56:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.159109 ========= master_lag: 1.81 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-03-25 19:57:00.781051) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 19:57:00.784242) ========= 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.d4lId5Ruwh/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.kmZWM5DSaZ/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2e339a4c538fd3f15f54b6c24a3dd3c564014798b0ddb0c9a6a718a57c6f2a53c419981b3469a6e90635f16d6e8b0470f588c49909a0ff310003a1e07d001d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d12663ae10b2b9af8a752f95d0bd7c5013fb5492b86f87b65d003096a0c2ba9a4e3bd36e6b0fed89481d39cc1975764582433206db52facbbfa117b31d5d2ce"} build_url:https://queue.taskcluster.net/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011130 build_url: 'https://queue.taskcluster.net/v1/task/DlWQfXUUSUeDcXDlZgQhuA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2e339a4c538fd3f15f54b6c24a3dd3c564014798b0ddb0c9a6a718a57c6f2a53c419981b3469a6e90635f16d6e8b0470f588c49909a0ff310003a1e07d001d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d12663ae10b2b9af8a752f95d0bd7c5013fb5492b86f87b65d003096a0c2ba9a4e3bd36e6b0fed89481d39cc1975764582433206db52facbbfa117b31d5d2ce"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 19:57:00.826837) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 19:57:00.827176) ========= 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.d4lId5Ruwh/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.kmZWM5DSaZ/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.004976 ========= master_lag: 0.45 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 19:57:01.282363) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 19:57:01.282674) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 19:57:01.286246) ========= ========= Total master_lag: 2.49 =========