builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0067 starttime: 1458037766.87 results: success (0) buildid: 20160315024234 builduid: 12d15daa324242efb822906186ce9f6e revision: 4adc4cef81179df18fe4e7e8463e4240aca3ae95 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 03:29:26.868702) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 03:29:26.869150) ========= ========= Started set props: basedir (results: 0, elapsed: 14 secs) (at 2016-03-15 03:29:26.869435) ========= 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.FTMVNDGTjI/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.bLKaEjebBY/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.005583 basedir: '/builds/slave/test' ========= master_lag: 14.37 ========= ========= Finished set props: basedir (results: 0, elapsed: 14 secs) (at 2016-03-15 03:29:41.248553) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 17 secs) (at 2016-03-15 03:29:41.248897) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 17 secs) (at 2016-03-15 03:29:58.938065) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-15 03:29:58.938339) ========= 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.FTMVNDGTjI/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.bLKaEjebBY/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.005937 ========= master_lag: 1.95 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-15 03:30:00.894624) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 03:30:00.894969) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 03:30:00.895355) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2016-03-15 03:30:00.895654) ========= 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.FTMVNDGTjI/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.bLKaEjebBY/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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-15 03:30:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 45.9M=0s 2016-03-15 03:30:01 (45.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134569 ========= master_lag: 12.27 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2016-03-15 03:30:13.295934) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2016-03-15 03:30:13.296309) ========= 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.FTMVNDGTjI/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.bLKaEjebBY/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.026788 ========= master_lag: 6.82 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2016-03-15 03:30:20.138452) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-15 03:30:20.138767) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4adc4cef81179df18fe4e7e8463e4240aca3ae95 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 4adc4cef81179df18fe4e7e8463e4240aca3ae95 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FTMVNDGTjI/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.bLKaEjebBY/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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-15 03:30:20,707 truncating revision to first 12 chars 2016-03-15 03:30:20,707 Setting DEBUG logging. 2016-03-15 03:30:20,707 attempt 1/10 2016-03-15 03:30:20,707 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4adc4cef8117?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-15 03:30:22,081 unpacking tar archive at: mozilla-central-4adc4cef8117/testing/mozharness/ program finished with exit code 0 elapsedTime=1.624445 ========= master_lag: 1.27 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-15 03:30:23.035105) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 03:30:23.040569) ========= echo 4adc4cef81179df18fe4e7e8463e4240aca3ae95 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4adc4cef81179df18fe4e7e8463e4240aca3ae95'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FTMVNDGTjI/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.bLKaEjebBY/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 4adc4cef81179df18fe4e7e8463e4240aca3ae95 program finished with exit code 0 elapsedTime=0.006011 script_repo_revision: '4adc4cef81179df18fe4e7e8463e4240aca3ae95' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 03:30:23.097680) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 03:30:23.098017) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 03:30:23.204125) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-03-15 03:30:23.204587) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FTMVNDGTjI/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.bLKaEjebBY/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 03:30:23 INFO - MultiFileLogger online at 20160315 03:30:23 in /builds/slave/test 03:30:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:30:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:30:23 INFO - {'append_to_log': False, 03:30:23 INFO - 'base_work_dir': '/builds/slave/test', 03:30:23 INFO - 'blob_upload_branch': 'Firefox', 03:30:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:30:23 INFO - 'branch': 'Firefox', 03:30:23 INFO - 'buildbot_json_path': 'buildprops.json', 03:30:23 INFO - 'config_files': ('talos/mac_config.py',), 03:30:23 INFO - 'default_actions': ('clobber', 03:30:23 INFO - 'read-buildbot-config', 03:30:23 INFO - 'download-and-extract', 03:30:23 INFO - 'populate-webroot', 03:30:23 INFO - 'create-virtualenv', 03:30:23 INFO - 'install', 03:30:23 INFO - 'run-tests'), 03:30:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:30:23 INFO - 'download_minidump_stackwalk': True, 03:30:23 INFO - 'download_symbols': 'ondemand', 03:30:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:30:23 INFO - 'tooltool.py': '/tools/tooltool.py', 03:30:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:30:23 INFO - '/tools/misc-python/virtualenv.py')}, 03:30:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:30:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:30:23 INFO - 'installer_path': 'installer.exe', 03:30:23 INFO - 'log_level': 'info', 03:30:23 INFO - 'log_name': 'talos', 03:30:23 INFO - 'log_to_console': True, 03:30:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:30:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:30:23 INFO - 'opt_config_files': (), 03:30:23 INFO - 'pip_index': False, 03:30:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:30:23 INFO - 'cmd': ('bash', 03:30:23 INFO - '-c', 03:30:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:30:23 INFO - 'enabled': True, 03:30:23 INFO - 'halt_on_failure': False, 03:30:23 INFO - 'name': 'check_screen_resolution'},), 03:30:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:30:23 INFO - 'cmd': ('bash', 03:30:23 INFO - '-c', 03:30:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:30:23 INFO - 'enabled': True, 03:30:23 INFO - 'halt_on_failure': False, 03:30:23 INFO - 'name': 'check_screen_resolution'},), 03:30:23 INFO - 'run_cmd_checks_enabled': True, 03:30:23 INFO - 'sps_profile': False, 03:30:23 INFO - 'sps_profile_interval': 0, 03:30:23 INFO - 'suite': 'dromaeojs', 03:30:23 INFO - 'system_bits': '32', 03:30:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:30:23 INFO - 'title': 't-yosemite-r7-0067', 03:30:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:30:23 INFO - 'use_talos_json': True, 03:30:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:30:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:30:23 INFO - 'work_dir': 'build'} 03:30:23 INFO - ##### 03:30:23 INFO - ##### Running clobber step. 03:30:23 INFO - ##### 03:30:23 INFO - Running pre-action listener: _resource_record_pre_action 03:30:23 INFO - Running main action method: clobber 03:30:23 INFO - rmtree: /builds/slave/test/build 03:30:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:30:24 INFO - Running post-action listener: _resource_record_post_action 03:30:24 INFO - ##### 03:30:24 INFO - ##### Running read-buildbot-config step. 03:30:24 INFO - ##### 03:30:24 INFO - Running pre-action listener: _resource_record_pre_action 03:30:24 INFO - Running main action method: read_buildbot_config 03:30:24 INFO - Using buildbot properties: 03:30:24 INFO - { 03:30:24 INFO - "project": "", 03:30:24 INFO - "product": "firefox", 03:30:24 INFO - "script_repo_revision": "production", 03:30:24 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 03:30:24 INFO - "repository": "", 03:30:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 03:30:24 INFO - "buildid": "20160315024234", 03:30:24 INFO - "pgo_build": "False", 03:30:24 INFO - "basedir": "/builds/slave/test", 03:30:24 INFO - "buildnumber": 181, 03:30:24 INFO - "slavename": "t-yosemite-r7-0067", 03:30:24 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 03:30:24 INFO - "platform": "yosemite_r7", 03:30:24 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:30:24 INFO - "branch": "mozilla-central", 03:30:24 INFO - "repo_path": "mozilla-central", 03:30:24 INFO - "revision": "4adc4cef81179df18fe4e7e8463e4240aca3ae95", 03:30:24 INFO - "stage_platform": "macosx64", 03:30:24 INFO - "builduid": "12d15daa324242efb822906186ce9f6e", 03:30:24 INFO - "slavebuilddir": "test" 03:30:24 INFO - } 03:30:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 03:30:24 INFO - Running post-action listener: _resource_record_post_action 03:30:24 INFO - ##### 03:30:24 INFO - ##### Running download-and-extract step. 03:30:24 INFO - ##### 03:30:24 INFO - Running pre-action listener: _resource_record_pre_action 03:30:24 INFO - Running main action method: download_and_extract 03:30:24 INFO - mkdir: /builds/slave/test/build/tests 03:30: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')]} 03:30:24 INFO - https://queue.taskcluster.net/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:30:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 03:30:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 03:30:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 03:30:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 03:30:27 INFO - Downloaded 1199 bytes. 03:30:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 03:30:27 INFO - Using the following test package requirements: 03:30:27 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 03:30:27 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:30:27 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 03:30:27 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:30:27 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 03:30:27 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:30:27 INFO - u'jsshell-mac.zip'], 03:30:27 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:30:27 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 03:30:27 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 03:30:27 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:30:27 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 03:30:27 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:30:27 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 03:30:27 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:30:27 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 03:30:27 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:30:27 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 03:30:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:30: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')]} 03:30:27 INFO - https://queue.taskcluster.net/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:30:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:30:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:30:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:30:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:30:28 INFO - Downloaded 17852463 bytes. 03:30:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:30:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:30:31 INFO - Return code: 0 03:30:31 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:30:31 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')]} 03:30:31 INFO - https://queue.taskcluster.net/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:30:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:30:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:30:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:30:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:30:33 INFO - Downloaded 17852463 bytes. 03:30:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:30:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:30:37 INFO - Return code: 0 03:30:37 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')]} 03:30:37 INFO - https://queue.taskcluster.net/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:30:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 03:30:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 03:30:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 03:30:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:30:38 INFO - Downloaded 10845263 bytes. 03:30:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:30:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 03:30:38 INFO - Return code: 0 03:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:38 INFO - https://queue.taskcluster.net/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:30:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:30:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:30:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 03:30:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 03:30:42 INFO - Downloaded 111250993 bytes. 03:30:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:30:42 INFO - mkdir: /builds/slave/test/properties 03:30:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:30:42 INFO - Writing to file /builds/slave/test/properties/build_url 03:30:42 INFO - Contents: 03:30:42 INFO - build_url:https://queue.taskcluster.net/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:30:43 INFO - Running post-action listener: _resource_record_post_action 03:30:43 INFO - Running post-action listener: set_extra_try_arguments 03:30:43 INFO - ##### 03:30:43 INFO - ##### Running populate-webroot step. 03:30:43 INFO - ##### 03:30:43 INFO - Running pre-action listener: _resource_record_pre_action 03:30:43 INFO - Running main action method: populate_webroot 03:30:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:30:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:30:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:30:43 INFO - '--tppagecycles', 03:30:43 INFO - '7'], 03:30:43 INFO - 'tests': ['tsvgm']}}, 03:30:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:30:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:30:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:30:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:30:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:30:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:30:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:43 INFO - 'talos_options': ['--e10s'], 03:30:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:43 INFO - 'tests': ['damp', 'tps']}, 03:30:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:43 INFO - 'talos_options': ['--e10s'], 03:30:43 INFO - 'tests': ['damp', 'tps']}, 03:30:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:30:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:30:43 INFO - 'other': {'tests': ['a11yr', 03:30:43 INFO - 'ts_paint', 03:30:43 INFO - 'tpaint', 03:30:43 INFO - 'sessionrestore', 03:30:43 INFO - 'sessionrestore_no_auto_restore', 03:30:43 INFO - 'tabpaint']}, 03:30:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:30:43 INFO - 'tests': ['a11yr', 03:30:43 INFO - 'ts_paint', 03:30:43 INFO - 'tpaint', 03:30:43 INFO - 'sessionrestore', 03:30:43 INFO - 'sessionrestore_no_auto_restore', 03:30:43 INFO - 'tabpaint']}, 03:30:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:30:43 INFO - 'tests': ['a11yr', 03:30:43 INFO - 'ts_paint', 03:30:43 INFO - 'tpaint', 03:30:43 INFO - 'sessionrestore', 03:30:43 INFO - 'sessionrestore_no_auto_restore', 03:30:43 INFO - 'tabpaint']}, 03:30:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:30:43 INFO - 'tests': ['a11yr', 03:30:43 INFO - 'ts_paint', 03:30:43 INFO - 'tpaint', 03:30:43 INFO - 'sessionrestore', 03:30:43 INFO - 'sessionrestore_no_auto_restore', 03:30:43 INFO - 'tabpaint']}, 03:30:43 INFO - 'other_l64': {'tests': ['a11yr', 03:30:43 INFO - 'ts_paint', 03:30:43 INFO - 'tpaint', 03:30:43 INFO - 'sessionrestore', 03:30:43 INFO - 'sessionrestore_no_auto_restore', 03:30:43 INFO - 'tabpaint']}, 03:30:43 INFO - 'other_nol64': {'tests': ['a11yr', 03:30:43 INFO - 'ts_paint', 03:30:43 INFO - 'tpaint', 03:30:43 INFO - 'sessionrestore', 03:30:43 INFO - 'sessionrestore_no_auto_restore', 03:30:43 INFO - 'tabpaint']}, 03:30:43 INFO - 'svgr': {'tests': ['tsvgx', 03:30:43 INFO - 'tsvgr_opacity', 03:30:43 INFO - 'tart', 03:30:43 INFO - 'tscrollx', 03:30:43 INFO - 'cart']}, 03:30:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:30:43 INFO - 'tests': ['tsvgx', 03:30:43 INFO - 'tsvgr_opacity', 03:30:43 INFO - 'tart', 03:30:43 INFO - 'tscrollx', 03:30:43 INFO - 'cart']}, 03:30:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:43 INFO - 'tests': ['tp5o']}, 03:30:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:43 INFO - 'talos_options': ['--e10s'], 03:30:43 INFO - 'tests': ['tp5o']}, 03:30:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:43 INFO - 'talos_options': ['--xperf_path', 03:30:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:43 INFO - 'tests': ['tp5n']}, 03:30:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:43 INFO - 'talos_options': ['--e10s', 03:30:43 INFO - '--xperf_path', 03:30:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:43 INFO - 'tests': ['tp5n']}}, 03:30:43 INFO - 'talos.zip': {'path': '', 03:30:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:30:43 INFO - Running post-action listener: _resource_record_post_action 03:30:43 INFO - ##### 03:30:43 INFO - ##### Running create-virtualenv step. 03:30:43 INFO - ##### 03:30:43 INFO - Running pre-action listener: _resource_record_pre_action 03:30:43 INFO - Running main action method: create_virtualenv 03:30:43 INFO - Creating virtualenv /builds/slave/test/build/venv 03:30:43 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 03:30:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:30:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:30:43 INFO - Using real prefix '/tools/python27' 03:30:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:30:44 INFO - Installing distribute.............................................................................................................................................................................................done. 03:30:47 INFO - Installing pip.................done. 03:30:47 INFO - Return code: 0 03:30:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106cbda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cc54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc31b488fc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b61d30>, '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 0x106985db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b58b20>, '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.FTMVNDGTjI/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.bLKaEjebBY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 03:30: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', 'pip>=1.5'] in /builds/slave/test/build 03:30: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 pip>=1.5 03:30:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FTMVNDGTjI/Render', 03:30:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:30:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:30:47 INFO - 'HOME': '/Users/cltbld', 03:30:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:30:47 INFO - 'LOGNAME': 'cltbld', 03:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:47 INFO - 'MOZ_NO_REMOTE': '1', 03:30:47 INFO - 'NO_EM_RESTART': '1', 03:30:47 INFO - 'PAGER': '/bin/cat', 03:30:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:47 INFO - 'PWD': '/builds/slave/test', 03:30:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:30:47 INFO - 'SHELL': '/bin/bash', 03:30:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bLKaEjebBY/Listeners', 03:30:47 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 03:30:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:30:47 INFO - 'USER': 'cltbld', 03:30:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:30:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:47 INFO - 'XPC_FLAGS': '0x0', 03:30:47 INFO - 'XPC_SERVICE_NAME': '0', 03:30:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:47 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 03:30:47 INFO - Cleaning up... 03:30:47 INFO - Return code: 0 03:30:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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', '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 0x106cbda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cc54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc31b488fc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b61d30>, '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 0x106985db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b58b20>, '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.FTMVNDGTjI/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.bLKaEjebBY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 03:30: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', 'psutil>=0.7.1'] in /builds/slave/test/build 03:30: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 psutil>=0.7.1 03:30:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FTMVNDGTjI/Render', 03:30:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:30:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:30:47 INFO - 'HOME': '/Users/cltbld', 03:30:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:30:47 INFO - 'LOGNAME': 'cltbld', 03:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:47 INFO - 'MOZ_NO_REMOTE': '1', 03:30:47 INFO - 'NO_EM_RESTART': '1', 03:30:47 INFO - 'PAGER': '/bin/cat', 03:30:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:47 INFO - 'PWD': '/builds/slave/test', 03:30:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:30:47 INFO - 'SHELL': '/bin/bash', 03:30:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bLKaEjebBY/Listeners', 03:30:47 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 03:30:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:30:47 INFO - 'USER': 'cltbld', 03:30:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:30:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:47 INFO - 'XPC_FLAGS': '0x0', 03:30:47 INFO - 'XPC_SERVICE_NAME': '0', 03:30:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:47 INFO - Downloading/unpacking psutil>=0.7.1 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:30:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:50 INFO - Installing collected packages: psutil 03:30:50 INFO - Running setup.py install for psutil 03:30:51 INFO - building 'psutil._psutil_osx' extension 03:30:51 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 03:30:51 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 03:30:51 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 03:30:51 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 03:30:51 INFO - building 'psutil._psutil_posix' extension 03:30:51 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 03:30:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:30:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:30:51 INFO - ^ 03:30:51 INFO - 1 warning generated. 03:30:51 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 03:30:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:52 INFO - Successfully installed psutil 03:30:52 INFO - Cleaning up... 03:30:52 INFO - Return code: 0 03:30:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:52 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 0x106cbda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cc54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc31b488fc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b61d30>, '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 0x106985db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b58b20>, '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.FTMVNDGTjI/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.bLKaEjebBY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 03:30:52 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 03:30:52 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 03:30:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FTMVNDGTjI/Render', 03:30:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:30:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:30:52 INFO - 'HOME': '/Users/cltbld', 03:30:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:30:52 INFO - 'LOGNAME': 'cltbld', 03:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:52 INFO - 'MOZ_NO_REMOTE': '1', 03:30:52 INFO - 'NO_EM_RESTART': '1', 03:30:52 INFO - 'PAGER': '/bin/cat', 03:30:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:52 INFO - 'PWD': '/builds/slave/test', 03:30:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:30:52 INFO - 'SHELL': '/bin/bash', 03:30:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bLKaEjebBY/Listeners', 03:30:52 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 03:30:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:30:52 INFO - 'USER': 'cltbld', 03:30:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:30:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:52 INFO - 'XPC_FLAGS': '0x0', 03:30:52 INFO - 'XPC_SERVICE_NAME': '0', 03:30:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:30:52 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 03:30:52 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 03:30:52 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 03:30:52 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 03:30:52 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 03:30:52 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 03:30:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:30:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:30:54 INFO - Installing collected packages: mozsystemmonitor 03:30:54 INFO - Running setup.py install for mozsystemmonitor 03:30:54 INFO - Successfully installed mozsystemmonitor 03:30:54 INFO - Cleaning up... 03:30:55 INFO - Return code: 0 03:30:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:30:55 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')]} 03:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:55 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')]} 03:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:55 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 0x106cbda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cc54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc31b488fc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b61d30>, '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 0x106985db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b58b20>, '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.FTMVNDGTjI/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.bLKaEjebBY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 03:30:55 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 03:30:55 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 03:30:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FTMVNDGTjI/Render', 03:30:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:30:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:30:55 INFO - 'HOME': '/Users/cltbld', 03:30:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:30:55 INFO - 'LOGNAME': 'cltbld', 03:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:55 INFO - 'MOZ_NO_REMOTE': '1', 03:30:55 INFO - 'NO_EM_RESTART': '1', 03:30:55 INFO - 'PAGER': '/bin/cat', 03:30:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:55 INFO - 'PWD': '/builds/slave/test', 03:30:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:30:55 INFO - 'SHELL': '/bin/bash', 03:30:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bLKaEjebBY/Listeners', 03:30:55 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 03:30:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:30:55 INFO - 'USER': 'cltbld', 03:30:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:30:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:55 INFO - 'XPC_FLAGS': '0x0', 03:30:55 INFO - 'XPC_SERVICE_NAME': '0', 03:30:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:55 INFO - Downloading/unpacking blobuploader==1.2.4 03:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:57 INFO - Downloading blobuploader-1.2.4.tar.gz 03:30:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:30:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:30:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:58 INFO - Downloading docopt-0.6.1.tar.gz 03:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:30:58 INFO - Installing collected packages: blobuploader, requests, docopt 03:30:58 INFO - Running setup.py install for blobuploader 03:30:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:30:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:30:59 INFO - Running setup.py install for requests 03:30:59 INFO - Running setup.py install for docopt 03:30:59 INFO - Successfully installed blobuploader requests docopt 03:30:59 INFO - Cleaning up... 03:30:59 INFO - Return code: 0 03:30:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:59 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 0x106cbda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cc54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc31b488fc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b61d30>, '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 0x106985db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b58b20>, '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.FTMVNDGTjI/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.bLKaEjebBY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 03:30:59 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 03:30:59 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 03:30:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FTMVNDGTjI/Render', 03:30:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:30:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:30:59 INFO - 'HOME': '/Users/cltbld', 03:30:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:30:59 INFO - 'LOGNAME': 'cltbld', 03:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:59 INFO - 'MOZ_NO_REMOTE': '1', 03:30:59 INFO - 'NO_EM_RESTART': '1', 03:30:59 INFO - 'PAGER': '/bin/cat', 03:30:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:59 INFO - 'PWD': '/builds/slave/test', 03:30:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:30:59 INFO - 'SHELL': '/bin/bash', 03:30:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bLKaEjebBY/Listeners', 03:30:59 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 03:30:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:30:59 INFO - 'USER': 'cltbld', 03:30:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:30:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:59 INFO - 'XPC_FLAGS': '0x0', 03:30:59 INFO - 'XPC_SERVICE_NAME': '0', 03:30:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:00 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-7ioKRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:00 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-5YiAd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:00 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-HBQxJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:00 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-7FrcbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:00 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-nUPngB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:00 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-Q44vQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:00 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-9OSgP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:00 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-fAzDC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:00 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-crwOB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:00 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-gxUy5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:01 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-23B0Ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:01 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-DRrT5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:01 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-kOy3nd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:01 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-00GSGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:01 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-IKDzhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:01 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-X_6A2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:01 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-nz_H7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:31:01 INFO - Running setup.py install for manifestparser 03:31:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:31:01 INFO - Running setup.py install for mozcrash 03:31:02 INFO - Running setup.py install for mozdebug 03:31:02 INFO - Running setup.py install for mozdevice 03:31:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:31:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:31:02 INFO - Running setup.py install for mozfile 03:31:02 INFO - Running setup.py install for mozhttpd 03:31:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:31:02 INFO - Running setup.py install for mozinfo 03:31:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:31:02 INFO - Running setup.py install for mozInstall 03:31:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:31:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:31:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:31:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:31:02 INFO - Running setup.py install for mozleak 03:31:03 INFO - Running setup.py install for mozlog 03:31:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:31:03 INFO - Running setup.py install for moznetwork 03:31:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:31:03 INFO - Running setup.py install for mozprocess 03:31:03 INFO - Running setup.py install for mozprofile 03:31:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:31:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:31:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:31:03 INFO - Running setup.py install for mozrunner 03:31:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:31:03 INFO - Running setup.py install for mozscreenshot 03:31:04 INFO - Running setup.py install for moztest 03:31:04 INFO - Running setup.py install for mozversion 03:31:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:31:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:31:04 INFO - Cleaning up... 03:31:04 INFO - Return code: 0 03:31:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:04 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 0x106cbda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cc54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc31b488fc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b61d30>, '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 0x106985db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b58b20>, '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.FTMVNDGTjI/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.bLKaEjebBY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 03:31:04 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 03:31:04 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 03:31:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FTMVNDGTjI/Render', 03:31:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:31:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:31:04 INFO - 'HOME': '/Users/cltbld', 03:31:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:31:04 INFO - 'LOGNAME': 'cltbld', 03:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:04 INFO - 'MOZ_NO_REMOTE': '1', 03:31:04 INFO - 'NO_EM_RESTART': '1', 03:31:04 INFO - 'PAGER': '/bin/cat', 03:31:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:31:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:04 INFO - 'PWD': '/builds/slave/test', 03:31:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:31:04 INFO - 'SHELL': '/bin/bash', 03:31:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bLKaEjebBY/Listeners', 03:31:04 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 03:31:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:31:04 INFO - 'USER': 'cltbld', 03:31:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:31:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:04 INFO - 'XPC_FLAGS': '0x0', 03:31:04 INFO - 'XPC_SERVICE_NAME': '0', 03:31:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:31:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:04 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-nPhyLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:04 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)) 03:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:04 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-aVshAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:04 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)) 03:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:04 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-dgfUdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:04 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)) 03:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:04 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-EheVyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:05 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)) 03:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:05 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-7yblOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:05 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)) 03:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:05 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-gKu9RS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:05 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)) 03:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:05 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-MRmH87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:05 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)) 03:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:05 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-g84Y00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:05 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)) 03:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:05 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-a3P1OV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:05 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)) 03:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:05 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-xJdgpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:05 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)) 03:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:05 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-vvZm57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:05 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)) 03:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:05 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-trRZT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:05 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)) 03:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:05 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-tYfy90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:06 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)) 03:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:06 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-louryJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:06 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)) 03:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:06 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-MeIv3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:06 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)) 03:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:06 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-P2mufu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:06 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)) 03:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:06 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-mSW0AG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:06 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)) 03:31:06 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)) 03:31:06 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)) 03:31:06 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)) 03:31:06 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)) 03:31:06 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)) 03:31:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:08 INFO - Downloading blessings-1.6.tar.gz 03:31:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:31:09 INFO - Installing collected packages: blessings 03:31:09 INFO - Running setup.py install for blessings 03:31:09 INFO - Successfully installed blessings 03:31:09 INFO - Cleaning up... 03:31:09 INFO - Return code: 0 03:31:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:31:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:09 INFO - Reading from file tmpfile_stdout 03:31:09 INFO - Current package versions: 03:31:09 INFO - blessings == 1.6 03:31:09 INFO - blobuploader == 1.2.4 03:31:09 INFO - docopt == 0.6.1 03:31:09 INFO - manifestparser == 1.1 03:31:09 INFO - mozInstall == 1.12 03:31:09 INFO - mozcrash == 0.17 03:31:09 INFO - mozdebug == 0.1 03:31:09 INFO - mozdevice == 0.48 03:31:09 INFO - mozfile == 1.2 03:31:09 INFO - mozhttpd == 0.7 03:31:09 INFO - mozinfo == 0.9 03:31:09 INFO - mozleak == 0.1 03:31:09 INFO - mozlog == 3.1 03:31:09 INFO - moznetwork == 0.27 03:31:09 INFO - mozprocess == 0.22 03:31:09 INFO - mozprofile == 0.28 03:31:09 INFO - mozrunner == 6.11 03:31:09 INFO - mozscreenshot == 0.1 03:31:09 INFO - mozsystemmonitor == 0.0 03:31:09 INFO - moztest == 0.7 03:31:09 INFO - mozversion == 1.4 03:31:09 INFO - psutil == 3.1.1 03:31:09 INFO - requests == 1.2.3 03:31:09 INFO - wsgiref == 0.1.2 03:31:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:09 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')]} 03:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:09 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')]} 03:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:09 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 0x106cbda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cc54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc31b488fc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b61d30>, '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 0x106985db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b58b20>, '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.FTMVNDGTjI/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.bLKaEjebBY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 03:31:09 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 03:31:09 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 03:31:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FTMVNDGTjI/Render', 03:31:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:31:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:31:09 INFO - 'HOME': '/Users/cltbld', 03:31:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:31:09 INFO - 'LOGNAME': 'cltbld', 03:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:09 INFO - 'MOZ_NO_REMOTE': '1', 03:31:09 INFO - 'NO_EM_RESTART': '1', 03:31:09 INFO - 'PAGER': '/bin/cat', 03:31:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:09 INFO - 'PWD': '/builds/slave/test', 03:31:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:31:09 INFO - 'SHELL': '/bin/bash', 03:31:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bLKaEjebBY/Listeners', 03:31:09 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 03:31:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:31:09 INFO - 'USER': 'cltbld', 03:31:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:31:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:09 INFO - 'XPC_FLAGS': '0x0', 03:31:09 INFO - 'XPC_SERVICE_NAME': '0', 03:31:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:09 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)) 03:31:09 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)) 03:31:09 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)) 03:31:09 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)) 03:31:09 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)) 03:31:09 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)) 03:31:09 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)) 03:31:09 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)) 03:31:09 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)) 03:31:09 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)) 03:31:09 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)) 03:31:09 INFO - Cleaning up... 03:31:09 INFO - Return code: 0 03:31:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:31:09 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')]} 03:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:09 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')]} 03:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:09 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 0x106cbda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cc54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc31b488fc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b61d30>, '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 0x106985db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b58b20>, '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.FTMVNDGTjI/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.bLKaEjebBY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 03:31:09 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 03:31:09 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 03:31:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FTMVNDGTjI/Render', 03:31:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:31:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:31:09 INFO - 'HOME': '/Users/cltbld', 03:31:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:31:09 INFO - 'LOGNAME': 'cltbld', 03:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:09 INFO - 'MOZ_NO_REMOTE': '1', 03:31:09 INFO - 'NO_EM_RESTART': '1', 03:31:09 INFO - 'PAGER': '/bin/cat', 03:31:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:09 INFO - 'PWD': '/builds/slave/test', 03:31:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:31:09 INFO - 'SHELL': '/bin/bash', 03:31:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bLKaEjebBY/Listeners', 03:31:09 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 03:31:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:31:09 INFO - 'USER': 'cltbld', 03:31:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:31:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:09 INFO - 'XPC_FLAGS': '0x0', 03:31:09 INFO - 'XPC_SERVICE_NAME': '0', 03:31:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:10 INFO - Downloading/unpacking jsonschema 03:31:10 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 03:31:10 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 03:31:10 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 03:31:10 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 03:31:10 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 03:31:10 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 03:31:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:31:12 INFO - Downloading/unpacking functools32 (from jsonschema) 03:31:12 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 03:31:12 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 03:31:12 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 03:31:12 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 03:31:12 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 03:31:12 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 03:31:12 INFO - Downloading functools32-3.2.3-2.tar.gz 03:31:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:31:12 INFO - warning: no files found matching '*.txt' 03:31:12 INFO - no previously-included directories found matching 'build' 03:31:12 INFO - no previously-included directories found matching 'dist' 03:31:12 INFO - no previously-included directories found matching '.git*' 03:31:12 INFO - Installing collected packages: jsonschema, functools32 03:31:12 INFO - Running setup.py install for functools32 03:31:13 INFO - warning: no files found matching '*.txt' 03:31:13 INFO - no previously-included directories found matching 'build' 03:31:13 INFO - no previously-included directories found matching 'dist' 03:31:13 INFO - no previously-included directories found matching '.git*' 03:31:13 INFO - Successfully installed jsonschema functools32 03:31:13 INFO - Cleaning up... 03:31:13 INFO - Return code: 0 03:31:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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')]} 03:31:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:13 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 0x106cbda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cc54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc31b488fc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b61d30>, '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 0x106985db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b58b20>, '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.FTMVNDGTjI/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.bLKaEjebBY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 03:31:13 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 03:31:13 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 03:31:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FTMVNDGTjI/Render', 03:31:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:31:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:31:13 INFO - 'HOME': '/Users/cltbld', 03:31:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:31:13 INFO - 'LOGNAME': 'cltbld', 03:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:13 INFO - 'MOZ_NO_REMOTE': '1', 03:31:13 INFO - 'NO_EM_RESTART': '1', 03:31:13 INFO - 'PAGER': '/bin/cat', 03:31:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:13 INFO - 'PWD': '/builds/slave/test', 03:31:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:31:13 INFO - 'SHELL': '/bin/bash', 03:31:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bLKaEjebBY/Listeners', 03:31:13 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 03:31:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:31:13 INFO - 'USER': 'cltbld', 03:31:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:31:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:13 INFO - 'XPC_FLAGS': '0x0', 03:31:13 INFO - 'XPC_SERVICE_NAME': '0', 03:31:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:31:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:13 INFO - Downloading/unpacking flake8 03:31:13 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 03:31:13 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 03:31:13 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 03:31:13 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 03:31:13 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 03:31:13 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 03:31:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:31:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:31:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:31:16 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 03:31:16 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 03:31:16 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 03:31:16 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 03:31:16 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 03:31:16 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 03:31:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:31:16 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 03:31:16 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 03:31:16 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 03:31:16 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 03:31:16 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 03:31:16 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 03:31:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:31:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:31:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:31:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:31:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:31:16 INFO - no previously-included directories found matching 'docs/_build' 03:31:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:31:17 INFO - Running setup.py install for pep8 03:31:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:31:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:31:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:31:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:31:17 INFO - no previously-included directories found matching 'docs/_build' 03:31:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:31:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:31:17 INFO - Cleaning up... 03:31:17 INFO - Return code: 0 03:31:17 INFO - Running post-action listener: _resource_record_post_action 03:31:17 INFO - Running post-action listener: _start_resource_monitoring 03:31:17 INFO - Starting resource monitoring. 03:31:17 INFO - ##### 03:31:17 INFO - ##### Running install step. 03:31:17 INFO - ##### 03:31:17 INFO - Running pre-action listener: _resource_record_pre_action 03:31:17 INFO - Running main action method: install 03:31:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:17 INFO - Reading from file tmpfile_stdout 03:31:17 INFO - Detecting whether we're running mozinstall >=1.0... 03:31:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:31:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:31:17 INFO - Reading from file tmpfile_stdout 03:31:17 INFO - Output received: 03:31:17 INFO - Usage: mozinstall [options] installer 03:31:17 INFO - Options: 03:31:17 INFO - -h, --help show this help message and exit 03:31:17 INFO - -d DEST, --destination=DEST 03:31:17 INFO - Directory to install application into. [default: 03:31:17 INFO - "/builds/slave/test"] 03:31:17 INFO - --app=APP Application being installed. [default: firefox] 03:31:17 INFO - mkdir: /builds/slave/test/build/application 03:31:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:31:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:31:51 INFO - Reading from file tmpfile_stdout 03:31:51 INFO - Output received: 03:31:51 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:31:51 INFO - Running post-action listener: _resource_record_post_action 03:31:51 INFO - ##### 03:31:51 INFO - ##### Running run-tests step. 03:31:51 INFO - ##### 03:31:51 INFO - Running pre-action listener: _resource_record_pre_action 03:31:51 INFO - Running main action method: run_tests 03:31:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:31:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:31:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:31:51 INFO - 2016-03-15 03:31:51.883 screenresolution[1647:7820] starting screenresolution argv=screenresolution get 03:31:51 INFO - 2016-03-15 03:31:51.885 screenresolution[1647:7820] Display 0: 1600x1200x32@60 03:31:51 INFO - 2016-03-15 03:31:51.891 screenresolution[1648:7823] starting screenresolution argv=screenresolution list 03:31:51 INFO - Available Modes on Display 0 03:31:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:31:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:31:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:31:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:31:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:31:52 INFO - Intel Iris: 03:31:52 INFO - Chipset Model: Intel Iris 03:31:52 INFO - Type: GPU 03:31:52 INFO - Bus: Built-In 03:31:52 INFO - VRAM (Dynamic, Max): 1536 MB 03:31:52 INFO - Vendor: Intel (0x8086) 03:31:52 INFO - Device ID: 0x0a2e 03:31:52 INFO - Revision ID: 0x0009 03:31:52 INFO - Displays: 03:31:52 INFO - Display: 03:31:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:31:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:31:52 INFO - Display Serial Number: 1600x1200 60 03:31:52 INFO - Main Display: Yes 03:31:52 INFO - Mirror: Off 03:31:52 INFO - Online: Yes 03:31:52 INFO - Rotation: Supported 03:31:52 INFO - Return code: 0 03:31:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:31:52 INFO - Python 2.7.3 03:31:52 INFO - Return code: 0 03:31:52 INFO - grabbing minidump binary from tooltool 03:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:52 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 0x106b61d30>, '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 0x106985db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b58b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:31:52 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 03:31:52 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 03:31:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:31:52 INFO - Return code: 0 03:31:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:31:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:31:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:31:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:31:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:31:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:31:53 INFO - Return code: 0 03:31:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0067', '--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 03:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0067 --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 03:31:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FTMVNDGTjI/Render', 03:31:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:31:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:31:53 INFO - 'HOME': '/Users/cltbld', 03:31:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:31:53 INFO - 'LOGNAME': 'cltbld', 03:31:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:31:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:53 INFO - 'MOZ_NO_REMOTE': '1', 03:31:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:31:53 INFO - 'NO_EM_RESTART': '1', 03:31:53 INFO - 'PAGER': '/bin/cat', 03:31:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:53 INFO - 'PWD': '/builds/slave/test', 03:31:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:31:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:31:53 INFO - 'SHELL': '/bin/bash', 03:31:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bLKaEjebBY/Listeners', 03:31:53 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 03:31:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:31:53 INFO - 'USER': 'cltbld', 03:31:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:31:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:53 INFO - 'XPC_FLAGS': '0x0', 03:31:53 INFO - 'XPC_SERVICE_NAME': '0', 03:31:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:31:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0067', '--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 03:31:53 INFO - mozversion application_buildid: 20160315024234 03:31:53 INFO - mozversion application_changeset: 4adc4cef81179df18fe4e7e8463e4240aca3ae95 03:31:53 INFO - mozversion application_display_name: Nightly 03:31:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:31:53 INFO - mozversion application_name: Firefox 03:31:53 INFO - mozversion application_remotingname: firefox 03:31:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:31:53 INFO - mozversion application_vendor: Mozilla 03:31:53 INFO - mozversion application_version: 48.0a1 03:31:53 INFO - mozversion platform_buildid: 20160315024234 03:31:53 INFO - mozversion platform_changeset: 4adc4cef81179df18fe4e7e8463e4240aca3ae95 03:31:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:31:53 INFO - mozversion platform_version: 48.0a1 03:31:53 INFO - using testdate: 1458037913 03:31:53 INFO - actual date: 1458037913 03:31:53 INFO - starting webserver on 'localhost:49270' 03:31:53 INFO - SUITE-START | Running 2 tests 03:31:53 INFO - TEST-START | dromaeo_css 03:31:53 INFO - operating with platform_type : mac_ 03:31:53 INFO - Initialising browser for dromaeo_css test... 03:31:53 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmppLEgqx/profile http://localhost:49270/getInfo.html) 03:31:55 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 03:31:55 INFO - PROCESS | 1666 | colorDepth:24 03:31:55 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 03:31:55 INFO - PROCESS | 1666 | __metrics 03:31:56 INFO - PROCESS | 1666 | 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" 03:31:56 ERROR - PROCESS | 1666 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:31:56 INFO - TEST-INFO | 1666: exit 0 03:31:56 INFO - Browser initialized. 03:31:56 INFO - Running cycle 1/1 for dromaeo_css test... 03:31:56 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmppLEgqx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:08 INFO - PROCESS | 1669 | RSS: Main: 243109888 03:32:08 INFO - PROCESS | 1669 | 03:33:00 INFO - PROCESS | 1669 | 1458037980174 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] 03:35:10 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 03:35:11 INFO - PROCESS | 1669 | RSS: Main: 332726272 03:35:11 INFO - PROCESS | 1669 | 03:38:13 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 03:38:14 INFO - PROCESS | 1669 | RSS: Main: 377073664 03:38:14 INFO - PROCESS | 1669 | 03:41:16 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 03:41:17 INFO - PROCESS | 1669 | RSS: Main: 373002240 03:41:17 INFO - PROCESS | 1669 | 03:44:19 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 03:44:19 INFO - PROCESS | 1669 | RSS: Main: 336613376 03:44:19 INFO - PROCESS | 1669 | 03:47:22 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 03:47:23 INFO - PROCESS | 1669 | RSS: Main: 336773120 03:47:23 INFO - PROCESS | 1669 | 03:50:26 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 03:50:26 INFO - PROCESS | 1669 | RSS: Main: 454246400 03:50:26 INFO - PROCESS | 1669 | 03:50:26 INFO - PROCESS | 1669 | __start_tp_report 03:50:26 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 03:50:26 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 03:50:26 INFO - PROCESS | 1669 | |i|pagename|runs| 03:50:26 INFO - PROCESS | 1669 | |0;dojo.html;3435.2614187949584;3451.119964409077;3494.580650321962;3497.898162078943;3531.752777305588;5600.85997850054;5615.382307946123;5625.859353516159;5636.267285252917;5654.943450565488;5590.972045139779;5628.690422026787;5658.405867383927;5678.744456499458;5698.202251684767;5142.717150556718;5170.53465188133;5191.221316802491;5207;5264.236685680574;5261.815836445725;5265.420803711589;5266.789328426858;5273.34083239595;5277.577793776508;5141.897162056756;5169.147090730025;5193.091209038422;5194.013137503881;5217.58259339252;5224.373075230958;5256.3429571303395;5270.736463176826;5300.575953923677;5316.627836051478;5058.974705126451;5098.566621837148;5115.386153661547;5184.092783762864;5195.636305458619;5471.042567550702;5487.204355368449;5487.560995120421;5530.5022547970875;5576.442355764431;6099.847503812396;6103.176071230371;6126.295476020226;6128.754849806002;6132.141500189977;4432.667549933735;6096.329403765627;6201.81394558164;6203.534734894901;6244.500439964792;5772;5772.278465191851;5784.999999999958;5786.594938354317;5796.536277097822;5831.300243970751;6109.84725381869;6277.686115694197;6304.716287767062;6310.589811662319;5910.083936989773;6040.818775436744;6093.451589356979;6096.526685943624;6148.585825260126;6178.845528861814;6233;6240.31356550779;6241.34465881085;6254.6247225166635;6100.0849872519475;6154.415330543591;6202.224721909762;6209.472194863397;6213.316535181127;4965.503449655078;6129.450483694044;6144.754209831557;6185.969070154621;6197.845053873599;4862.902741945141;4869.245266983623;4869.269609558523;4902.264660300983;4910.48439913811;4389.29771236607;4397.450318710161;4411.514733379326;4414.492333381702;4457.108578284291;5591.245181900473;5661.886762264731;5690.829275121753;5733.569982251264;5750.568707346965;6214.689265536705;6242.781502647385;6263.906041409383;6280.591761535486;6282.434580887742;5674.4892959633835;5689.2603961485565;5721.77112915487;5731.484166424958;5747.540196784247;5224.242484839677;5307.734613269321;5328.786848526093;5364.195370694427;5390.137577987503;6279.560430769802;6294.276158241769;6306.9684651576445;6310.779122730591;6317.241930968313;6113.5414843886;6217.782377616762;6251;6278.905816412849;6305.90541141874;6249.500039996698;6305;6332.30344662096;6333.65164915934;6345.428911397997;6117.265928088658;6158.753649853956;6181.350958149509;6188.412100850412;6191.597546159665;6110.619513019744;6117.84705382369;6239.625622462667;6254.718537665907;6256.718447669775;6077.24034495688;6094.7432096071825;6118.832384214075;6121.540884433596;6123.40463689004;5830.883382332415;6044.032954727222;6079.726412311368;6081.057436097235;6090.573659843769;4997.750112494288;5676.091825307931;5863;5933.673647949232;5939.554533409925;5898.351181370132;5996.790112346047;6035.818925432244;6092.4046167529195;6096.060335417393;5874.882502350015;5914.497267732291;5925.703714814328;5929.407059294036;5936.465718085393 03:50:26 INFO - PROCESS | 1669 | |1;ext.html;462.1842448079139;489.34672212596183;542.557815380465;588.9957622254058;636.2333388267137;38082.619173808256;38410;38513.80743096284;38517.614823851756;38588.42117368235;43164.48924287643;43422.78288608552;43485;43493;43520.782396088056;9472.431654100741;9685.418874867495;9690;9712;9713.174380177694;9551.188149007343;9698.563564639573;9702.272329575275;9864.358816676893;9888.505574721272;9801.215902727801;9872.308938374317;9913.206943444507;9918.256130790183;9963.103320701135;9762.707118786413;9846.409215447096;9850.458224797634;9865.852012219822;9868.753281167956;9554.23566114716;9666.661666841626;9678.806423871554;9683.612655493771;9685.564149613285;41616.95957601054;42044.15911681749;42053.1589368214;42078.579214208075;42103.78948105271;3343.8996830095134;3385.6783605557434;3482.721382289436;3764.3036038333;3810.161764411825;29362.559561606595;30304.54543181832;30351.089467315796;30497.390052198833;30536.931207407633;2707.6144811069603;2776.6667999839947;2776.7917406194415;2836.2342167614834;2929.3848291858735;475894;476010;476701.6164919188;476805;477060;68125;69338.65330673315;69399.65300173567;69527.65236173887;69556;73129.26870731331;73401.26598733944;73505.26494735091;73603;73677.89483157756;17307.826921730873;17529.211185496682;17539.473815785546;17545.91227043882;17578.208980595904;13065.608031759062;13118.737625247442;13141;13157.868421315856;13178.406971686298;19709.11308991099;21529.461763456038;21767.734839773842;21787.782122178574;21908.671369929463;7332.266773322625;8352.415330926777;8361.414700970996;8399.874001889977;8409.579521023925;985.5170966226498;985.9063388978036;1011.5448048378112;1029.9288739710616;1093.1965005720788;28945.276368090545;29189.048864748474;29456.821727131104;29548.556771648444;29912.953046643262;1091.8307662312354;1158.177693837368;1164.6273192578294;1188.494889671886;1205.2768338996707;12053.337066461429;14655.560333190022;15099.320530576151;15185.848141518665;15411.537653870402;523116;527263;528492;529192;530254;60195.39804601898;61581.384186157564;61609.69195153996;61751;62045.44886377786;1162;1324.3378310844578;1458.0449805377707;1482.8220613526446;1607.541850572581;28705.856470717514;28870.133895983156;28895.277618059717;29429.705702942698;29473.410531789672;47559.286610700176;47739;48202.75898620485;48207.27689084596;48338.5166148334;311091;363214;370604;371280;371504;28886.566701499916;29439.705602943697;34362.65637343695;34976.82511587426;35509;44389.55610443854;44961.77519112384;45167.548324516334;45274;46504;30606.08181754551;37373.6262637381;37379.43930841094;37456;38395.80802095972;36459.270814583026;36521;36788.264234715694;37011.69062068524;37273.25453490969;35958.460623091196;36377.454338185475;36599;36748;37452.62547374491;31069.291188984822;31568.842155789072;32736.017919462454;32776;32878.506822397205;19982.70025949641;22209.777902220772;22464.583199132016;24313.725490195513;24811 03:50:26 INFO - PROCESS | 1669 | |2;jquery.html;360.861068488632;361.272036845756;362.7950208132405;366.74144727966785;374.8556805629832;19542.41372758816;19948;20746.896265518688;21357.038933248023;21404;17019.914900425512;20724;20742.792572074275;21213.893930530365;21214;5622.887542249153;5930.911036334458;5964.940350596482;5971.85070373242;5972.372900845414;4154.626083652471;4300.612944834964;5872.853178670546;6389.424951754341;6409.198850143732;6319.620822750627;6338.144350512691;6348.619082855043;6355.491560675135;6355.523335749815;5327.827877866883;5768.826935191951;6347.174867267272;6362.713677884506;6364.618122912617;5430.185472179165;5468.371137319219;5510.421405752419;5511.779528818843;5521.309836270466;21831.454213644785;22843.200487983006;22849;22866.31401057971;23342.416439588975;1999.740033795612;2046.4986078410736;2063.587282543497;2097.0982477534653;2098.150249149082;9243.445393276357;9484.525773711286;9821.017898210193;10012.699619011368;12097.576584819577;1674.2549565443383;1704.548294701905;1710.324421853361;1760.5510594798372;1761.0930370859019;95013.52493237559;95116;101463.49268253686;102373;102413;11051.392173430379;11137.05335046514;11202.49588768491;11224.663260102046;11327.943360283145;13418.261995590141;13437.32813359328;13447.731045379038;13489.392977316043;13521.729565408637;8384.455010424303;8581.656733730706;8599.656013759504;8672.56637168139;8692.217700406994;8771.16673915977;8799.692010779592;8800.691975780817;8900.910990890137;8903.866442003375;4379.277419225792;4464.15181115587;4471.150481408522;4516.638668906479;4523.84166554169;1769.2303847825979;1812.238859678938;1827.808080151565;1838.301445450747;1888.3673969220465;883.3154305413356;906.8503696890072;920.3838238575705;948.9762755931018;953.4708236928433;19479.318223862098;19980.50048748793;20120.798792011894;20254.898725506573;20284.79715202829;959.194276807485;974.8391515400021;978.5889926230858;985.8915519292872;999.2562977603982;10578.365298082139;10674.199435042403;10786;10824.72938176536;10839.024487796136;602880;612966;613904;625137;631300;107524.0109392887;107689.4615526933;109366;113567;117139;981.1316984468797;983.1986930651497;996.2428554298785;997.6857289953641;1015.1320620869199;17386.82921954662;17459.912700436926;17748.733768993217;18078.096095194924;18150.909245453688;47123.764381177876;47478.52521474879;47580.52419475761;48404.75797620989;48852;68838;69790.65104674647;69943;70196;70626.64686676739;7362.815929601803;7581.469297149147;7616.961915190389;7848.843023139391;7877.606119694107;8358.707445239388;9101.453912765255;11671.860215107208;11977.820332695192;12254.693632659255;8771.736847894574;10301.845472318071;10458.163346932075;10476.020539661782;10742.570297188026;10199.796004079728;10425.895741042492;10460.424676642857;10488.737781555523;10661.89338106609;10597.89402105969;10788.730281743019;10979.121670266519;10980.835287470854;11032.28290161137;7531.849363012819;7633;7692.153863075169;7706.152323244327;7964.123946366011;10153.796924061626;10611.832698403325;10711;10824.24230303871;10861.34831910088 03:50:26 INFO - PROCESS | 1669 | |3;mootools.html;1253.5675192058736;1591.371408293724;1635.0434995527617;1932.8692714761864;2069.617120832645;8026.879596806045;8657.567121643924;8851.203391694746;8858.822823543533;8861;8667.39328247023;8873.378863479558;8883.777905552348;8890.42212256203;8891.244244239231;2176.4885251965775;2439.4023464251195;2462.6429167770707;2488.875556222191;2497.2383423055962;2519.4583164619603;2527.5703130467773;2529.6584961030303;2534.8605826679527;2535.6957165140116;2120.3003009007066;2377.940551486218;2486.8880900359527;2503.674522312097;2510.7112682041616;2457.3610861176044;2474.3319303788057;2482.1312540610734;2500.274920273119;2502.51201015802;2407.7953373963232;2416.8549887006834;2433.8661373624445;2435.9647149961197;2439.829211955164;8791.516466594334;8860.778480537974;8867.379283450162;8868.714036464677;8874.245689116367;5435.537979271767;5578.107502799533;5588.21764952907;5590.105583106724;5595.440455954413;3538.168530395355;3684.5762737285286;3721.79530125843;3734.159814041846;3736.327461057009;1041.1046500009986;1051.7107795356262;1060.8726952765717;1063.9414832184227;1074.5433190893839;10047.447390393598;12138.332391718452;12150.5747298845;12167.452464639113;12169.452374643162;4300.913981720348;4650.6046986005895;4860.4896485869185;4924.4090709115135;5032.949670503322;10188.388696678223;10206.030427109412;10210.642627508001;10224.233182511342;10224.539895704711;5483.588730845203;5490.231367608538;5511.724413779295;5522.199281104217;5525.640833345819;4165.250254954077;4441.866743997685;4582.106489234634;4831.299461578052;4983.401991761012;3933.2920074386884;4034.092329225901;4036.6770658347264;4046.1300820323772;4094.0379010932406;1315.2568798628745;1319.967000824968;1323.7490571410117;1331.2079312808862;1333.7799263121476;1347.023408029171;1356.8100465934776;1360.7006458579096;1394.9511767088104;1398.9650258743613;8279;8366.163383661586;8425.662973480992;8426.03100643434;8445.408821382443;515.2889013161813;523.670087844663;531.5641174237088;531.614579429918;531.8989392015504;5407.972485227794;6224.844378890564;6246.094316324107;6319.273283572356;6320.5575609706875;10237.539310731036;10830.512626931806;10875.78248435027;11014.779704405866;11040.282381645167;10489.160867130611;10705.036546710679;10711.78576428467;10822.458877056273;10893.727656808644;7405.555666660018;8485.406021578554;8487.108853570286;8494.235518803214;8558.743237702878;7941.444098913021;8058.758237252891;8073.555954422563;8098.3521318293215;8122.634481448231;9717.514124293899;9747.707568772948;9749.268804839807;9795.755106122404;9935;9920.355176913477;10108.949455252676;10123.949380253052;10227.181825454094;10250.641227557;6840.7263709453055;6857.005734168617;7231.63841807897;7679.3856491481665;7756.806079848049;8324.334053275603;8378.371622128487;8388.874166887379;8407.15928407179;8418.915810841812;7273.454490913097;7348.853022939618;7395.186529481645;7492.962535187289;7555.848883022419;7307.963460182665;7311.23232060626;7330.523515971445;7394.223606521453;7438.330550250504;7811.609419529114;7829.217078292353;7882.014748156481;7883.881741773764;7889.960550197212;7047.647617619201;7070.823229419306;7107.466939979418;7145.39264162552;7150.284971503016;7180.60506672138;7204.279572042754;7247.710091596488;7267.491275610657;7278.381337586365 03:50:26 INFO - PROCESS | 1669 | |4;prototype.html;320.6697101984956;325.2356961141318;328.54168435033114;332.51784911877775;333.3532946084594;6565.474762019039;6577.967110164454;6581.506387020974;6609.636469994149;6618.735250589983;6499.252585952617;6529.053287273355;6555.606663600187;6560.343965603437;6562.737490500374;4599.40207772989;4693.507181745918;4707.293905914106;4818.614510839142;4853.611711063115;4807.495213002637;4813.951860481403;4823.589994850442;4829.710217386951;4837.443693975185;4755.239161734124;4774.546418090275;4897.877553061184;4907.6073914086965;4908.582770464514;4569.109023740372;4643.257078867398;4757.09615173116;4778.474367819537;4826.734529600871;4060.8984775380554;4061.1268577255737;4096.508418989741;4101.651359634435;4113.938290925638;6267.937320626781;6272.027835685476;6273;6289.182406287154;6292.339304373067;5565.526930210896;5569.721513924328;5574.637648552831;5577.079781835992;5602.439756024406;5907.734151963172;6683.732650693966;6911.2397636259975;6917.654117294115;6965.407940325078;4268.701190916637;4440.844570440019;4448.777561121963;4450.732956022649;4601.010782681739;6523.217213934358;6718.992151177314;7200.603966781825;7373.115226172894;7379.114506259283;4584.816607335736;4586.2661974083985;4588.036512332447;4588.059447813191;4593.63250939924;4608.654350923694;4627.907441851212;4641.327007583949;4643.210654188796;4651.186042442559;5297.973510132501;5521.917171242435;5527.917081243784;5528.668279903219;5535.6955367454375;5662.490375866192;5986.311574169026;6749.156355455568;6971.407430368374;7009.7897063088185;1330.9201447913156;1587.7221486239862;1588.5075626555574;1609.8631616312744;1611.9032858028556;1019.37308555238;1027.209049032241;1034.3173505486343;1047.6280920273193;1047.6909311753052;5724.971375143097;6274.61958369158;6284.214473190851;6494.155759751202;6671.766488172891;7317.292601737391;7332.486725929134;7338.486305958639;7339.743108991266;7349.228331025272;6654.633995130217;6656.667166641649;6660.467162626978;6668.433183179484;6676.232233293136;3826.8469261229798;3868.5551161616213;3870.903227419337;3874.2832575973534;3876.4185372193833;7261.41908647307;7605.6957721691615;7632.5038872473115;7634.465587408939;7660.770176894702;7458.477906546598;7471;7472.514286571464;7483.289087536676;7509.249075092447;7587.355074818703;7613.1831222446945;7625.733099341496;7626.42801789868;7647.388208943271;6218.751249949952;7273.527220730635;7282.781516554512;7304.4156467483535;7307.8538429232185;7090.822729431806;7114.466415018791;7174.390176835028;7191.928080719126;7199.928000720135;7634.4655874088285;7636.427267954815;7651.655675494505;7653.617319134132;7673.693052278069;4565.748883811422;4592.839250626212;4605.861824145281;4606.792694328697;4617.030423610945;6973.19808222061;7241.094863142107;7242.275772422716;7248.0939882514685;7249.202587715453;6645.966770166118;7021.648917554204;7067.71729130829;7218.530795498275;7227.457940654577;5310.707911064928;7003.089598352181;7020.087388639444;7023.297670232936;7027.402670773042;6861.519693621399;6864;6875.140607424072;6880.0367948486255;6886.690098945459;6701.832454188684;7023.719051237893;7030.261822508767;7032.789016329519;7034.331738484836;6578.5395022347975;6768.661566921733;6775.796726098225;6845.418139458003;6853.143357080365 03:50:26 INFO - PROCESS | 1669 | |5;yui.html;703.2826516952708;740.210124164279;747.1072068877693;747.9925200747991;810.7284059839953;14863.033902796311;15025.624359391008;15045.849541504582;15052.247387630601;15067.020643658168;13690.726185476284;13747.93126034371;13761.17432954021;13775;13810.585682429542;737.601695084655;932.4964519159646;933.3979583168885;934.6588495199237;939.8308304505186;736.4108713029582;749.6738918570412;906.4697152165958;916.1434059154678;938.0994245524305;976.8925418203992;980.0101897083925;987.254622759819;987.2644879564734;989.1690979577154;977.8875429325648;979.3829887171072;981.1415011864655;981.1709105805583;981.4552923127661;571.0606053042762;713.7180813578659;725.5392825555757;725.9165196002474;728.231715540105;14622.415103395851;14649.19429431381;14669.70660586793;14692.70614587713;14703.485378011825;12451.501939922393;12499.93750031244;12615.684607884785;12623.431945562472;12756.234625922381;10011.299209055369;10030.448325342104;10083.344582602182;10141.492925353703;10459.94770026145;3441.0709108540805;3518.7888726676224;3568.2007699643937;3604.2250916052913;3625.8187090645624;74266;74266.25733742648;74308.51382972364;74421;74460.51078978444;9171.510540102283;9481.24150067993;9498.382605130644;9588.90411095894;10333.741656458498;20872.895635521727;21033.15867365288;21089.68365474519;21095.472613184487;21115.26096586612;7442.032535770315;7580.9620951895995;7667.501612395176;7767.02912135983;7788.961055194801;4106.67146628269;4144;4217.1776503581505;4278.89302767427;4452.0873220989615;3629.129009037812;3694.722895782827;3701.7038636908983;3706.610805865399;3720.2373513429684;549.9139200079891;597.1818608506287;678.6301465701106;679.1341040173818;692.7229108356597;516.651260399229;579.2672269578986;595.5057302438966;604.5012864386898;604.957652964297;7965.123836377994;8155.83688326242;8212.260896519341;8289.875651865226;8584.484930904166;568.9971550142222;572.5133636409103;598.86525531755;607.492743559133;617.607819034916;3819.4652748615217;3824.464574959508;3873.96126038736;3988.6011398859882;4065.3698676705158;87121.56439217764;90629.54685226531;90952;91057.54471227733;92110;62615;64394.67802660957;73866.63066684632;74400;75378.6231068852;55742.88514229774;57028.71485642628;57108.71445642745;57354;58639.99999999915;8116.715914942949;8319.916800832156;8389.832203355776;8391.538465384463;8417.158284171534;38678;45946;47249.055018900115;47510.52489475061;47566;61924.69037654783;62981.68509157425;64159.3960151;64164.3583564177;64678.353216467236;10768.3538987661;10801.837972430578;11173.385463799568;11250.66248012561;11268;10483.161347092062;11879.821802672794;11917.52329906794;12020.33888136161;12896.161749486253;10932.945335273273;11392.43037848121;11426.485808138488;12356.320402377596;12480.687982800502;10027.949860250652;11504.309741415542;11936.388403285186;12007.219530730474;12033.518659253532;11114.722131946766;11134;11446.141539384413;11507.654770356903;11613.709657258636;9423.29325300619;9511;9724;9853.704388868346;10099.242556808122;8774.868376974478;9217.723468295962;9320.207782338577;9466.384684995453;9564.569594368131 03:50:26 INFO - PROCESS | 1669 | __end_tp_report 03:50:26 INFO - PROCESS | 1669 | __start_cc_report 03:50:26 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1097 03:50:26 INFO - PROCESS | 1669 | __end_cc_report 03:50:26 INFO - PROCESS | 1669 | __startTimestamp1458039026758__endTimestamp 03:50:26 INFO - PROCESS | 1669 | 03:50:26 INFO - PROCESS | 1669 | ------- Summary: start ------- 03:50:26 INFO - PROCESS | 1669 | Number of tests: 6 03:50:26 INFO - PROCESS | 1669 | 03:50:26 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5692.56 Median:5874.88 stddev:627.22 (10.7%) stddev-sans-first:603.63 03:50:26 INFO - PROCESS | 1669 | Values: 3435.3 3451.1 3494.6 3497.9 3531.8 5600.9 5615.4 5625.9 5636.3 5654.9 5591.0 5628.7 5658.4 5678.7 5698.2 5142.7 5170.5 5191.2 5207.0 5264.2 5261.8 5265.4 5266.8 5273.3 5277.6 5141.9 5169.1 5193.1 5194.0 5217.6 5224.4 5256.3 5270.7 5300.6 5316.6 5059.0 5098.6 5115.4 5184.1 5195.6 5471.0 5487.2 5487.6 5530.5 5576.4 6099.8 6103.2 6126.3 6128.8 6132.1 4432.7 6096.3 6201.8 6203.5 6244.5 5772.0 5772.3 5785.0 5786.6 5796.5 5831.3 6109.8 6277.7 6304.7 6310.6 5910.1 6040.8 6093.5 6096.5 6148.6 6178.8 6233.0 6240.3 6241.3 6254.6 6100.1 6154.4 6202.2 6209.5 6213.3 4965.5 6129.5 6144.8 6186.0 6197.8 4862.9 4869.2 4869.3 4902.3 4910.5 4389.3 4397.5 4411.5 4414.5 4457.1 5591.2 5661.9 5690.8 5733.6 5750.6 6214.7 6242.8 6263.9 6280.6 6282.4 5674.5 5689.3 5721.8 5731.5 5747.5 5224.2 5307.7 5328.8 5364.2 5390.1 6279.6 6294.3 6307.0 6310.8 6317.2 6113.5 6217.8 6251.0 6278.9 6305.9 6249.5 6305.0 6332.3 6333.7 6345.4 6117.3 6158.8 6181.4 6188.4 6191.6 6110.6 6117.8 6239.6 6254.7 6256.7 6077.2 6094.7 6118.8 6121.5 6123.4 5830.9 6044.0 6079.7 6081.1 6090.6 4997.8 5676.1 5863.0 5933.7 5939.6 5898.4 5996.8 6035.8 6092.4 6096.1 5874.9 5914.5 5925.7 5929.4 5936.5 03:50:26 INFO - PROCESS | 1669 | 03:50:26 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:61187.49 Median:20923.46 stddev:122075.67 (583.4%) stddev-sans-first:122332.98 03:50:26 INFO - PROCESS | 1669 | Values: 462.2 489.3 542.6 589.0 636.2 38082.6 38410.0 38513.8 38517.6 38588.4 43164.5 43422.8 43485.0 43493.0 43520.8 9472.4 9685.4 9690.0 9712.0 9713.2 9551.2 9698.6 9702.3 9864.4 9888.5 9801.2 9872.3 9913.2 9918.3 9963.1 9762.7 9846.4 9850.5 9865.9 9868.8 9554.2 9666.7 9678.8 9683.6 9685.6 41617.0 42044.2 42053.2 42078.6 42103.8 3343.9 3385.7 3482.7 3764.3 3810.2 29362.6 30304.5 30351.1 30497.4 30536.9 2707.6 2776.7 2776.8 2836.2 2929.4 475894.0 476010.0 476701.6 476805.0 477060.0 68125.0 69338.7 69399.7 69527.7 69556.0 73129.3 73401.3 73505.3 73603.0 73677.9 17307.8 17529.2 17539.5 17545.9 17578.2 13065.6 13118.7 13141.0 13157.9 13178.4 19709.1 21529.5 21767.7 21787.8 21908.7 7332.3 8352.4 8361.4 8399.9 8409.6 985.5 985.9 1011.5 1029.9 1093.2 28945.3 29189.0 29456.8 29548.6 29913.0 1091.8 1158.2 1164.6 1188.5 1205.3 12053.3 14655.6 15099.3 15185.8 15411.5 523116.0 527263.0 528492.0 529192.0 530254.0 60195.4 61581.4 61609.7 61751.0 62045.4 1162.0 1324.3 1458.0 1482.8 1607.5 28705.9 28870.1 28895.3 29429.7 29473.4 47559.3 47739.0 48202.8 48207.3 48338.5 311091.0 363214.0 370604.0 371280.0 371504.0 28886.6 29439.7 34362.7 34976.8 35509.0 44389.6 44961.8 45167.5 45274.0 46504.0 30606.1 37373.6 37379.4 37456.0 38395.8 36459.3 36521.0 36788.3 37011.7 37273.3 35958.5 36377.5 36599.0 36748.0 37452.6 31069.3 31568.8 32736.0 32776.0 32878.5 19982.7 22209.8 22464.6 24313.7 24811.0 03:50:26 INFO - PROCESS | 1669 | 03:50:26 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:33896.37 Median:364.77 stddev:102038.11 (27973.4%) stddev-sans-first:102293.28 03:50:26 INFO - PROCESS | 1669 | Values: 360.9 361.3 362.8 366.7 374.9 19542.4 19948.0 20746.9 21357.0 21404.0 17019.9 20724.0 20742.8 21213.9 21214.0 5622.9 5930.9 5964.9 5971.9 5972.4 4154.6 4300.6 5872.9 6389.4 6409.2 6319.6 6338.1 6348.6 6355.5 6355.5 5327.8 5768.8 6347.2 6362.7 6364.6 5430.2 5468.4 5510.4 5511.8 5521.3 21831.5 22843.2 22849.0 22866.3 23342.4 1999.7 2046.5 2063.6 2097.1 2098.2 9243.4 9484.5 9821.0 10012.7 12097.6 1674.3 1704.5 1710.3 1760.6 1761.1 95013.5 95116.0 101463.5 102373.0 102413.0 11051.4 11137.1 11202.5 11224.7 11327.9 13418.3 13437.3 13447.7 13489.4 13521.7 8384.5 8581.7 8599.7 8672.6 8692.2 8771.2 8799.7 8800.7 8900.9 8903.9 4379.3 4464.2 4471.2 4516.6 4523.8 1769.2 1812.2 1827.8 1838.3 1888.4 883.3 906.9 920.4 949.0 953.5 19479.3 19980.5 20120.8 20254.9 20284.8 959.2 974.8 978.6 985.9 999.3 10578.4 10674.2 10786.0 10824.7 10839.0 602880.0 612966.0 613904.0 625137.0 631300.0 107524.0 107689.5 109366.0 113567.0 117139.0 981.1 983.2 996.2 997.7 1015.1 17386.8 17459.9 17748.7 18078.1 18150.9 47123.8 47478.5 47580.5 48404.8 48852.0 68838.0 69790.7 69943.0 70196.0 70626.6 7362.8 7581.5 7617.0 7848.8 7877.6 8358.7 9101.5 11671.9 11977.8 12254.7 8771.7 10301.8 10458.2 10476.0 10742.6 10199.8 10425.9 10460.4 10488.7 10661.9 10597.9 10788.7 10979.1 10980.8 11032.3 7531.8 7633.0 7692.2 7706.2 7964.1 10153.8 10611.8 10711.0 10824.2 10861.3 03:50:26 INFO - PROCESS | 1669 | 03:50:26 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:6098.73 Median:527.62 stddev:3244.58 (614.9%) stddev-sans-first:3233.23 03:50:26 INFO - PROCESS | 1669 | Values: 1253.6 1591.4 1635.0 1932.9 2069.6 8026.9 8657.6 8851.2 8858.8 8861.0 8667.4 8873.4 8883.8 8890.4 8891.2 2176.5 2439.4 2462.6 2488.9 2497.2 2519.5 2527.6 2529.7 2534.9 2535.7 2120.3 2377.9 2486.9 2503.7 2510.7 2457.4 2474.3 2482.1 2500.3 2502.5 2407.8 2416.9 2433.9 2436.0 2439.8 8791.5 8860.8 8867.4 8868.7 8874.2 5435.5 5578.1 5588.2 5590.1 5595.4 3538.2 3684.6 3721.8 3734.2 3736.3 1041.1 1051.7 1060.9 1063.9 1074.5 10047.4 12138.3 12150.6 12167.5 12169.5 4300.9 4650.6 4860.5 4924.4 5032.9 10188.4 10206.0 10210.6 10224.2 10224.5 5483.6 5490.2 5511.7 5522.2 5525.6 4165.3 4441.9 4582.1 4831.3 4983.4 3933.3 4034.1 4036.7 4046.1 4094.0 1315.3 1320.0 1323.7 1331.2 1333.8 1347.0 1356.8 1360.7 1395.0 1399.0 8279.0 8366.2 8425.7 8426.0 8445.4 515.3 523.7 531.6 531.6 531.9 5408.0 6224.8 6246.1 6319.3 6320.6 10237.5 10830.5 10875.8 11014.8 11040.3 10489.2 10705.0 10711.8 10822.5 10893.7 7405.6 8485.4 8487.1 8494.2 8558.7 7941.4 8058.8 8073.6 8098.4 8122.6 9717.5 9747.7 9749.3 9795.8 9935.0 9920.4 10108.9 10123.9 10227.2 10250.6 6840.7 6857.0 7231.6 7679.4 7756.8 8324.3 8378.4 8388.9 8407.2 8418.9 7273.5 7348.9 7395.2 7493.0 7555.8 7308.0 7311.2 7330.5 7394.2 7438.3 7811.6 7829.2 7882.0 7883.9 7890.0 7047.6 7070.8 7107.5 7145.4 7150.3 7180.6 7204.3 7247.7 7267.5 7278.4 03:50:26 INFO - PROCESS | 1669 | 03:50:26 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:5701.12 Median:6526.14 stddev:1833.20 (28.1%) stddev-sans-first:1793.31 03:50:26 INFO - PROCESS | 1669 | Values: 320.7 325.2 328.5 332.5 333.4 6565.5 6578.0 6581.5 6609.6 6618.7 6499.3 6529.1 6555.6 6560.3 6562.7 4599.4 4693.5 4707.3 4818.6 4853.6 4807.5 4814.0 4823.6 4829.7 4837.4 4755.2 4774.5 4897.9 4907.6 4908.6 4569.1 4643.3 4757.1 4778.5 4826.7 4060.9 4061.1 4096.5 4101.7 4113.9 6267.9 6272.0 6273.0 6289.2 6292.3 5565.5 5569.7 5574.6 5577.1 5602.4 5907.7 6683.7 6911.2 6917.7 6965.4 4268.7 4440.8 4448.8 4450.7 4601.0 6523.2 6719.0 7200.6 7373.1 7379.1 4584.8 4586.3 4588.0 4588.1 4593.6 4608.7 4627.9 4641.3 4643.2 4651.2 5298.0 5521.9 5527.9 5528.7 5535.7 5662.5 5986.3 6749.2 6971.4 7009.8 1330.9 1587.7 1588.5 1609.9 1611.9 1019.4 1027.2 1034.3 1047.6 1047.7 5725.0 6274.6 6284.2 6494.2 6671.8 7317.3 7332.5 7338.5 7339.7 7349.2 6654.6 6656.7 6660.5 6668.4 6676.2 3826.8 3868.6 3870.9 3874.3 3876.4 7261.4 7605.7 7632.5 7634.5 7660.8 7458.5 7471.0 7472.5 7483.3 7509.2 7587.4 7613.2 7625.7 7626.4 7647.4 6218.8 7273.5 7282.8 7304.4 7307.9 7090.8 7114.5 7174.4 7191.9 7199.9 7634.5 7636.4 7651.7 7653.6 7673.7 4565.7 4592.8 4605.9 4606.8 4617.0 6973.2 7241.1 7242.3 7248.1 7249.2 6646.0 7021.6 7067.7 7218.5 7227.5 5310.7 7003.1 7020.1 7023.3 7027.4 6861.5 6864.0 6875.1 6880.0 6886.7 6701.8 7023.7 7030.3 7032.8 7034.3 6578.5 6768.7 6775.8 6845.4 6853.1 03:50:26 INFO - PROCESS | 1669 | 03:50:26 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:17246.30 Median:28966.63 stddev:23549.59 (81.3%) stddev-sans-first:23582.90 03:50:26 INFO - PROCESS | 1669 | Values: 703.3 740.2 747.1 748.0 810.7 14863.0 15025.6 15045.8 15052.2 15067.0 13690.7 13747.9 13761.2 13775.0 13810.6 737.6 932.5 933.4 934.7 939.8 736.4 749.7 906.5 916.1 938.1 976.9 980.0 987.3 987.3 989.2 977.9 979.4 981.1 981.2 981.5 571.1 713.7 725.5 725.9 728.2 14622.4 14649.2 14669.7 14692.7 14703.5 12451.5 12499.9 12615.7 12623.4 12756.2 10011.3 10030.4 10083.3 10141.5 10459.9 3441.1 3518.8 3568.2 3604.2 3625.8 74266.0 74266.3 74308.5 74421.0 74460.5 9171.5 9481.2 9498.4 9588.9 10333.7 20872.9 21033.2 21089.7 21095.5 21115.3 7442.0 7581.0 7667.5 7767.0 7789.0 4106.7 4144.0 4217.2 4278.9 4452.1 3629.1 3694.7 3701.7 3706.6 3720.2 549.9 597.2 678.6 679.1 692.7 516.7 579.3 595.5 604.5 605.0 7965.1 8155.8 8212.3 8289.9 8584.5 569.0 572.5 598.9 607.5 617.6 3819.5 3824.5 3874.0 3988.6 4065.4 87121.6 90629.5 90952.0 91057.5 92110.0 62615.0 64394.7 73866.6 74400.0 75378.6 55742.9 57028.7 57108.7 57354.0 58640.0 8116.7 8319.9 8389.8 8391.5 8417.2 38678.0 45946.0 47249.1 47510.5 47566.0 61924.7 62981.7 64159.4 64164.4 64678.4 10768.4 10801.8 11173.4 11250.7 11268.0 10483.2 11879.8 11917.5 12020.3 12896.2 10932.9 11392.4 11426.5 12356.3 12480.7 10027.9 11504.3 11936.4 12007.2 12033.5 11114.7 11134.0 11446.1 11507.7 11613.7 9423.3 9511.0 9724.0 9853.7 10099.2 8774.9 9217.7 9320.2 9466.4 9564.6 03:50:26 INFO - PROCESS | 1669 | -------- Summary: end -------- 03:50:26 INFO - PROCESS | 1669 | 03:50:27 INFO - TEST-INFO | 1669: exit 0 03:50:27 INFO - TEST-OK | dromaeo_css | took 1113678ms 03:50:27 INFO - TEST-START | kraken 03:50:27 INFO - operating with platform_type : mac_ 03:50:27 INFO - Initialising browser for kraken test... 03:50:27 INFO - TEST-INFO | started process 1697 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmprPXU2U/profile http://localhost:49270/getInfo.html) 03:50:29 INFO - PROCESS | 1697 | __metrics Screen width/height:1600/1200 03:50:29 INFO - PROCESS | 1697 | colorDepth:24 03:50:29 INFO - PROCESS | 1697 | Browser inner width/height: 1024/689 03:50:29 INFO - PROCESS | 1697 | __metrics 03:50:29 INFO - PROCESS | 1697 | 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" 03:50:29 ERROR - PROCESS | 1697 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:50:30 INFO - TEST-INFO | 1697: exit 0 03:50:30 INFO - Browser initialized. 03:50:30 INFO - Running cycle 1/1 for kraken test... 03:50:30 INFO - TEST-INFO | started process 1699 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmprPXU2U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:50:42 INFO - PROCESS | 1699 | RSS: Main: 243531776 03:50:42 INFO - PROCESS | 1699 | 03:50:45 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 03:50:45 INFO - PROCESS | 1699 | RSS: Main: 289243136 03:50:45 INFO - PROCESS | 1699 | 03:50:48 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 03:50:49 INFO - PROCESS | 1699 | RSS: Main: 300412928 03:50:49 INFO - PROCESS | 1699 | 03:50:54 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 03:50:55 INFO - PROCESS | 1699 | RSS: Main: 288444416 03:50:55 INFO - PROCESS | 1699 | 03:50:57 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 03:50:57 INFO - PROCESS | 1699 | RSS: Main: 291127296 03:50:57 INFO - PROCESS | 1699 | 03:50:59 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:51:00 INFO - PROCESS | 1699 | RSS: Main: 291741696 03:51:00 INFO - PROCESS | 1699 | 03:51:03 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 03:51:03 INFO - PROCESS | 1699 | RSS: Main: 291778560 03:51:03 INFO - PROCESS | 1699 | 03:51:07 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 03:51:07 INFO - PROCESS | 1699 | RSS: Main: 289116160 03:51:07 INFO - PROCESS | 1699 | 03:51:10 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 03:51:10 INFO - PROCESS | 1699 | RSS: Main: 289492992 03:51:10 INFO - PROCESS | 1699 | 03:51:12 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:51:13 INFO - PROCESS | 1699 | RSS: Main: 324886528 03:51:13 INFO - PROCESS | 1699 | 03:51:14 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:51:15 INFO - PROCESS | 1699 | RSS: Main: 324055040 03:51:15 INFO - PROCESS | 1699 | 03:51:17 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:51:18 INFO - PROCESS | 1699 | RSS: Main: 331075584 03:51:18 INFO - PROCESS | 1699 | 03:51:20 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:51:21 INFO - PROCESS | 1699 | RSS: Main: 332369920 03:51:21 INFO - PROCESS | 1699 | 03:51:24 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:51:24 INFO - PROCESS | 1699 | RSS: Main: 333770752 03:51:24 INFO - PROCESS | 1699 | 03:51:26 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 03:51:26 INFO - PROCESS | 1699 | RSS: Main: 392884224 03:51:26 INFO - PROCESS | 1699 | 03:51:26 INFO - PROCESS | 1699 | __start_tp_report 03:51:26 INFO - PROCESS | 1699 | _x_x_mozilla_page_load 03:51:26 INFO - PROCESS | 1699 | _x_x_mozilla_page_load_details 03:51:26 INFO - PROCESS | 1699 | |i|pagename|runs| 03:51:26 INFO - PROCESS | 1699 | |0;ai-astar;111;108;111;109;111;110;119;110;111;110 03:51:26 INFO - PROCESS | 1699 | |1;audio-beat-detection;172;160;147;181;148;142;170;148;195;116 03:51:26 INFO - PROCESS | 1699 | |2;audio-dft;385;380;381;384;383;376;379;385;380;382 03:51:26 INFO - PROCESS | 1699 | |3;audio-fft;79;75;85;78;56;57;58;81;78;56 03:51:26 INFO - PROCESS | 1699 | |4;audio-oscillator;94;98;129;80;77;89;111;77;84;110 03:51:26 INFO - PROCESS | 1699 | |5;imaging-gaussian-blur;88;84;87;83;86;84;87;83;86;84 03:51:26 INFO - PROCESS | 1699 | |6;imaging-darkroom;156;156;157;158;156;155;156;157;156;156 03:51:26 INFO - PROCESS | 1699 | |7;imaging-desaturate;86;84;84;84;84;86;85;83;85;84 03:51:26 INFO - PROCESS | 1699 | |8;json-parse-financial;55;55;55;53;53;54;55;63;56;53 03:51:26 INFO - PROCESS | 1699 | |9;json-stringify-tinderbox;65;72;70;74;71;67;66;67;67;69 03:51:26 INFO - PROCESS | 1699 | |10;stanford-crypto-aes;84;82;83;83;84;82;83;82;82;83 03:51:26 INFO - PROCESS | 1699 | |11;stanford-crypto-ccm;134;136;134;109;129;124;119;113;106;139 03:51:26 INFO - PROCESS | 1699 | |12;stanford-crypto-pbkdf2;138;130;174;179;137;129;140;140;174;134 03:51:26 INFO - PROCESS | 1699 | |13;stanford-crypto-sha256-iterative;67;67;68;66;67;67;66;66;67;66 03:51:26 INFO - PROCESS | 1699 | __end_tp_report 03:51:26 INFO - PROCESS | 1699 | __start_cc_report 03:51:26 INFO - PROCESS | 1699 | _x_x_mozilla_cycle_collect,1231 03:51:26 INFO - PROCESS | 1699 | __end_cc_report 03:51:26 INFO - PROCESS | 1699 | __startTimestamp1458039086555__endTimestamp 03:51:26 INFO - PROCESS | 1699 | 03:51:26 INFO - PROCESS | 1699 | ------- Summary: start ------- 03:51:26 INFO - PROCESS | 1699 | Number of tests: 14 03:51:26 INFO - PROCESS | 1699 | 03:51:26 INFO - PROCESS | 1699 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:2.98 (2.7%) stddev-sans-first:3.16 03:51:26 INFO - PROCESS | 1699 | Values: 111.0 108.0 111.0 109.0 111.0 110.0 119.0 110.0 111.0 110.0 03:51:26 INFO - PROCESS | 1699 | 03:51:26 INFO - PROCESS | 1699 | [#1] audio-beat-detection Cycles:10 Average:157.90 Median:165.00 stddev:22.57 (13.7%) stddev-sans-first:23.35 03:51:26 INFO - PROCESS | 1699 | Values: 172.0 160.0 147.0 181.0 148.0 142.0 170.0 148.0 195.0 116.0 03:51:26 INFO - PROCESS | 1699 | 03:51:26 INFO - PROCESS | 1699 | [#2] audio-dft Cycles:10 Average:381.50 Median:382.50 stddev:2.88 (0.8%) stddev-sans-first:2.76 03:51:26 INFO - PROCESS | 1699 | Values: 385.0 380.0 381.0 384.0 383.0 376.0 379.0 385.0 380.0 382.0 03:51:26 INFO - PROCESS | 1699 | 03:51:26 INFO - PROCESS | 1699 | [#3] audio-fft Cycles:10 Average:70.30 Median:78.00 stddev:11.94 (15.3%) stddev-sans-first:12.25 03:51:26 INFO - PROCESS | 1699 | Values: 79.0 75.0 85.0 78.0 56.0 57.0 58.0 81.0 78.0 56.0 03:51:26 INFO - PROCESS | 1699 | 03:51:26 INFO - PROCESS | 1699 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:82.00 stddev:17.25 (21.0%) stddev-sans-first:18.29 03:51:26 INFO - PROCESS | 1699 | Values: 94.0 98.0 129.0 80.0 77.0 89.0 111.0 77.0 84.0 110.0 03:51:26 INFO - PROCESS | 1699 | 03:51:26 INFO - PROCESS | 1699 | [#5] imaging-gaussian-blur Cycles:10 Average:85.20 Median:86.00 stddev:1.81 (2.1%) stddev-sans-first:1.62 03:51:26 INFO - PROCESS | 1699 | Values: 88.0 84.0 87.0 83.0 86.0 84.0 87.0 83.0 86.0 84.0 03:51:26 INFO - PROCESS | 1699 | 03:51:26 INFO - PROCESS | 1699 | [#6] imaging-darkroom Cycles:10 Average:156.30 Median:156.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 03:51:26 INFO - PROCESS | 1699 | Values: 156.0 156.0 157.0 158.0 156.0 155.0 156.0 157.0 156.0 156.0 03:51:26 INFO - PROCESS | 1699 | 03:51:26 INFO - PROCESS | 1699 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:84.50 stddev:0.97 (1.2%) stddev-sans-first:0.87 03:51:26 INFO - PROCESS | 1699 | Values: 86.0 84.0 84.0 84.0 84.0 86.0 85.0 83.0 85.0 84.0 03:51:26 INFO - PROCESS | 1699 | 03:51:26 INFO - PROCESS | 1699 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:2.94 (5.3%) stddev-sans-first:3.11 03:51:26 INFO - PROCESS | 1699 | Values: 55.0 55.0 55.0 53.0 53.0 54.0 55.0 63.0 56.0 53.0 03:51:26 INFO - PROCESS | 1699 | 03:51:26 INFO - PROCESS | 1699 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.50 stddev:2.90 (4.2%) stddev-sans-first:2.73 03:51:26 INFO - PROCESS | 1699 | Values: 65.0 72.0 70.0 74.0 71.0 67.0 66.0 67.0 67.0 69.0 03:51:26 INFO - PROCESS | 1699 | 03:51:26 INFO - PROCESS | 1699 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:0.79 (1.0%) stddev-sans-first:0.71 03:51:26 INFO - PROCESS | 1699 | Values: 84.0 82.0 83.0 83.0 84.0 82.0 83.0 82.0 82.0 83.0 03:51:26 INFO - PROCESS | 1699 | 03:51:26 INFO - PROCESS | 1699 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:131.50 stddev:11.96 (9.1%) stddev-sans-first:12.16 03:51:26 INFO - PROCESS | 1699 | Values: 134.0 136.0 134.0 109.0 129.0 124.0 119.0 113.0 106.0 139.0 03:51:26 INFO - PROCESS | 1699 | 03:51:26 INFO - PROCESS | 1699 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.50 Median:140.00 stddev:19.83 (14.2%) stddev-sans-first:20.74 03:51:26 INFO - PROCESS | 1699 | Values: 138.0 130.0 174.0 179.0 137.0 129.0 140.0 140.0 174.0 134.0 03:51:26 INFO - PROCESS | 1699 | 03:51:26 INFO - PROCESS | 1699 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 03:51:26 INFO - PROCESS | 1699 | Values: 67.0 67.0 68.0 66.0 67.0 67.0 66.0 66.0 67.0 66.0 03:51:26 INFO - PROCESS | 1699 | -------- Summary: end -------- 03:51:26 INFO - PROCESS | 1699 | 03:51:27 INFO - TEST-INFO | 1699: exit 0 03:51:27 INFO - TEST-OK | kraken | took 60240ms 03:51:27 INFO - SUITE-END | took 1173s 03:51:27 INFO - Completed test suite (00:19:34) 03:51:27 INFO - javascript benchmark 03:51:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3435.2614187949584, 3451.119964409077, 3494.580650321962, 3497.898162078943, 3531.752777305588, 5600.85997850054, 5615.382307946123, 5625.859353516159, 5636.267285252917, 5654.943450565488, 5590.972045139779, 5628.690422026787, 5658.405867383927, 5678.744456499458, 5698.202251684767, 5142.717150556718, 5170.53465188133, 5191.221316802491, 5207.0, 5264.236685680574, 5261.815836445725, 5265.420803711589, 5266.789328426858, 5273.34083239595, 5277.577793776508, 5141.897162056756, 5169.147090730025, 5193.091209038422, 5194.013137503881, 5217.58259339252, 5224.373075230958, 5256.3429571303395, 5270.736463176826, 5300.575953923677, 5316.627836051478, 5058.974705126451, 5098.566621837148, 5115.386153661547, 5184.092783762864, 5195.636305458619, 5471.042567550702, 5487.204355368449, 5487.560995120421, 5530.5022547970875, 5576.442355764431, 6099.847503812396, 6103.176071230371, 6126.295476020226, 6128.754849806002, 6132.141500189977, 4432.667549933735, 6096.329403765627, 6201.81394558164, 6203.534734894901, 6244.500439964792, 5772.0, 5772.278465191851, 5784.999999999958, 5786.594938354317, 5796.536277097822, 5831.300243970751, 6109.84725381869, 6277.686115694197, 6304.716287767062, 6310.589811662319, 5910.083936989773, 6040.818775436744, 6093.451589356979, 6096.526685943624, 6148.585825260126, 6178.845528861814, 6233.0, 6240.31356550779, 6241.34465881085, 6254.6247225166635, 6100.0849872519475, 6154.415330543591, 6202.224721909762, 6209.472194863397, 6213.316535181127, 4965.503449655078, 6129.450483694044, 6144.754209831557, 6185.969070154621, 6197.845053873599, 4862.902741945141, 4869.245266983623, 4869.269609558523, 4902.264660300983, 4910.48439913811, 4389.29771236607, 4397.450318710161, 4411.514733379326, 4414.492333381702, 4457.108578284291, 5591.245181900473, 5661.886762264731, 5690.829275121753, 5733.569982251264, 5750.568707346965, 6214.689265536705, 6242.781502647385, 6263.906041409383, 6280.591761535486, 6282.434580887742, 5674.4892959633835, 5689.2603961485565, 5721.77112915487, 5731.484166424958, 5747.540196784247, 5224.242484839677, 5307.734613269321, 5328.786848526093, 5364.195370694427, 5390.137577987503, 6279.560430769802, 6294.276158241769, 6306.9684651576445, 6310.779122730591, 6317.241930968313, 6113.5414843886, 6217.782377616762, 6251.0, 6278.905816412849, 6305.90541141874, 6249.500039996698, 6305.0, 6332.30344662096, 6333.65164915934, 6345.428911397997, 6117.265928088658, 6158.753649853956, 6181.350958149509, 6188.412100850412, 6191.597546159665, 6110.619513019744, 6117.84705382369, 6239.625622462667, 6254.718537665907, 6256.718447669775, 6077.24034495688, 6094.7432096071825, 6118.832384214075, 6121.540884433596, 6123.40463689004, 5830.883382332415, 6044.032954727222, 6079.726412311368, 6081.057436097235, 6090.573659843769, 4997.750112494288, 5676.091825307931, 5863.0, 5933.673647949232, 5939.554533409925, 5898.351181370132, 5996.790112346047, 6035.818925432244, 6092.4046167529195, 6096.060335417393, 5874.882502350015, 5914.497267732291, 5925.703714814328, 5929.407059294036, 5936.465718085393], "unit": "score", "name": "dojo.html", "value": 5655.3679605680145}, {"lowerIsBetter": false, "replicates": [462.1842448079139, 489.34672212596183, 542.557815380465, 588.9957622254058, 636.2333388267137, 38082.619173808256, 38410.0, 38513.80743096284, 38517.614823851756, 38588.42117368235, 43164.48924287643, 43422.78288608552, 43485.0, 43493.0, 43520.782396088056, 9472.431654100741, 9685.418874867495, 9690.0, 9712.0, 9713.174380177694, 9551.188149007343, 9698.563564639573, 9702.272329575275, 9864.358816676893, 9888.505574721272, 9801.215902727801, 9872.308938374317, 9913.206943444507, 9918.256130790183, 9963.103320701135, 9762.707118786413, 9846.409215447096, 9850.458224797634, 9865.852012219822, 9868.753281167956, 9554.23566114716, 9666.661666841626, 9678.806423871554, 9683.612655493771, 9685.564149613285, 41616.95957601054, 42044.15911681749, 42053.1589368214, 42078.579214208075, 42103.78948105271, 3343.8996830095134, 3385.6783605557434, 3482.721382289436, 3764.3036038333, 3810.161764411825, 29362.559561606595, 30304.54543181832, 30351.089467315796, 30497.390052198833, 30536.931207407633, 2707.6144811069603, 2776.6667999839947, 2776.7917406194415, 2836.2342167614834, 2929.3848291858735, 475894.0, 476010.0, 476701.6164919188, 476805.0, 477060.0, 68125.0, 69338.65330673315, 69399.65300173567, 69527.65236173887, 69556.0, 73129.26870731331, 73401.26598733944, 73505.26494735091, 73603.0, 73677.89483157756, 17307.826921730873, 17529.211185496682, 17539.473815785546, 17545.91227043882, 17578.208980595904, 13065.608031759062, 13118.737625247442, 13141.0, 13157.868421315856, 13178.406971686298, 19709.11308991099, 21529.461763456038, 21767.734839773842, 21787.782122178574, 21908.671369929463, 7332.266773322625, 8352.415330926777, 8361.414700970996, 8399.874001889977, 8409.579521023925, 985.5170966226498, 985.9063388978036, 1011.5448048378112, 1029.9288739710616, 1093.1965005720788, 28945.276368090545, 29189.048864748474, 29456.821727131104, 29548.556771648444, 29912.953046643262, 1091.8307662312354, 1158.177693837368, 1164.6273192578294, 1188.494889671886, 1205.2768338996707, 12053.337066461429, 14655.560333190022, 15099.320530576151, 15185.848141518665, 15411.537653870402, 523116.0, 527263.0, 528492.0, 529192.0, 530254.0, 60195.39804601898, 61581.384186157564, 61609.69195153996, 61751.0, 62045.44886377786, 1162.0, 1324.3378310844578, 1458.0449805377707, 1482.8220613526446, 1607.541850572581, 28705.856470717514, 28870.133895983156, 28895.277618059717, 29429.705702942698, 29473.410531789672, 47559.286610700176, 47739.0, 48202.75898620485, 48207.27689084596, 48338.5166148334, 311091.0, 363214.0, 370604.0, 371280.0, 371504.0, 28886.566701499916, 29439.705602943697, 34362.65637343695, 34976.82511587426, 35509.0, 44389.55610443854, 44961.77519112384, 45167.548324516334, 45274.0, 46504.0, 30606.08181754551, 37373.6262637381, 37379.43930841094, 37456.0, 38395.80802095972, 36459.270814583026, 36521.0, 36788.264234715694, 37011.69062068524, 37273.25453490969, 35958.460623091196, 36377.454338185475, 36599.0, 36748.0, 37452.62547374491, 31069.291188984822, 31568.842155789072, 32736.017919462454, 32776.0, 32878.506822397205, 19982.70025949641, 22209.777902220772, 22464.583199132016, 24313.725490195513, 24811.0], "unit": "score", "name": "ext.html", "value": 19926.544346266746}, {"lowerIsBetter": false, "replicates": [360.861068488632, 361.272036845756, 362.7950208132405, 366.74144727966785, 374.8556805629832, 19542.41372758816, 19948.0, 20746.896265518688, 21357.038933248023, 21404.0, 17019.914900425512, 20724.0, 20742.792572074275, 21213.893930530365, 21214.0, 5622.887542249153, 5930.911036334458, 5964.940350596482, 5971.85070373242, 5972.372900845414, 4154.626083652471, 4300.612944834964, 5872.853178670546, 6389.424951754341, 6409.198850143732, 6319.620822750627, 6338.144350512691, 6348.619082855043, 6355.491560675135, 6355.523335749815, 5327.827877866883, 5768.826935191951, 6347.174867267272, 6362.713677884506, 6364.618122912617, 5430.185472179165, 5468.371137319219, 5510.421405752419, 5511.779528818843, 5521.309836270466, 21831.454213644785, 22843.200487983006, 22849.0, 22866.31401057971, 23342.416439588975, 1999.740033795612, 2046.4986078410736, 2063.587282543497, 2097.0982477534653, 2098.150249149082, 9243.445393276357, 9484.525773711286, 9821.017898210193, 10012.699619011368, 12097.576584819577, 1674.2549565443383, 1704.548294701905, 1710.324421853361, 1760.5510594798372, 1761.0930370859019, 95013.52493237559, 95116.0, 101463.49268253686, 102373.0, 102413.0, 11051.392173430379, 11137.05335046514, 11202.49588768491, 11224.663260102046, 11327.943360283145, 13418.261995590141, 13437.32813359328, 13447.731045379038, 13489.392977316043, 13521.729565408637, 8384.455010424303, 8581.656733730706, 8599.656013759504, 8672.56637168139, 8692.217700406994, 8771.16673915977, 8799.692010779592, 8800.691975780817, 8900.910990890137, 8903.866442003375, 4379.277419225792, 4464.15181115587, 4471.150481408522, 4516.638668906479, 4523.84166554169, 1769.2303847825979, 1812.238859678938, 1827.808080151565, 1838.301445450747, 1888.3673969220465, 883.3154305413356, 906.8503696890072, 920.3838238575705, 948.9762755931018, 953.4708236928433, 19479.318223862098, 19980.50048748793, 20120.798792011894, 20254.898725506573, 20284.79715202829, 959.194276807485, 974.8391515400021, 978.5889926230858, 985.8915519292872, 999.2562977603982, 10578.365298082139, 10674.199435042403, 10786.0, 10824.72938176536, 10839.024487796136, 602880.0, 612966.0, 613904.0, 625137.0, 631300.0, 107524.0109392887, 107689.4615526933, 109366.0, 113567.0, 117139.0, 981.1316984468797, 983.1986930651497, 996.2428554298785, 997.6857289953641, 1015.1320620869199, 17386.82921954662, 17459.912700436926, 17748.733768993217, 18078.096095194924, 18150.909245453688, 47123.764381177876, 47478.52521474879, 47580.52419475761, 48404.75797620989, 48852.0, 68838.0, 69790.65104674647, 69943.0, 70196.0, 70626.64686676739, 7362.815929601803, 7581.469297149147, 7616.961915190389, 7848.843023139391, 7877.606119694107, 8358.707445239388, 9101.453912765255, 11671.860215107208, 11977.820332695192, 12254.693632659255, 8771.736847894574, 10301.845472318071, 10458.163346932075, 10476.020539661782, 10742.570297188026, 10199.796004079728, 10425.895741042492, 10460.424676642857, 10488.737781555523, 10661.89338106609, 10597.89402105969, 10788.730281743019, 10979.121670266519, 10980.835287470854, 11032.28290161137, 7531.849363012819, 7633.0, 7692.153863075169, 7706.152323244327, 7964.123946366011, 10153.796924061626, 10611.832698403325, 10711.0, 10824.24230303871, 10861.34831910088], "unit": "score", "name": "jquery.html", "value": 9187.577009531524}, {"lowerIsBetter": false, "replicates": [1253.5675192058736, 1591.371408293724, 1635.0434995527617, 1932.8692714761864, 2069.617120832645, 8026.879596806045, 8657.567121643924, 8851.203391694746, 8858.822823543533, 8861.0, 8667.39328247023, 8873.378863479558, 8883.777905552348, 8890.42212256203, 8891.244244239231, 2176.4885251965775, 2439.4023464251195, 2462.6429167770707, 2488.875556222191, 2497.2383423055962, 2519.4583164619603, 2527.5703130467773, 2529.6584961030303, 2534.8605826679527, 2535.6957165140116, 2120.3003009007066, 2377.940551486218, 2486.8880900359527, 2503.674522312097, 2510.7112682041616, 2457.3610861176044, 2474.3319303788057, 2482.1312540610734, 2500.274920273119, 2502.51201015802, 2407.7953373963232, 2416.8549887006834, 2433.8661373624445, 2435.9647149961197, 2439.829211955164, 8791.516466594334, 8860.778480537974, 8867.379283450162, 8868.714036464677, 8874.245689116367, 5435.537979271767, 5578.107502799533, 5588.21764952907, 5590.105583106724, 5595.440455954413, 3538.168530395355, 3684.5762737285286, 3721.79530125843, 3734.159814041846, 3736.327461057009, 1041.1046500009986, 1051.7107795356262, 1060.8726952765717, 1063.9414832184227, 1074.5433190893839, 10047.447390393598, 12138.332391718452, 12150.5747298845, 12167.452464639113, 12169.452374643162, 4300.913981720348, 4650.6046986005895, 4860.4896485869185, 4924.4090709115135, 5032.949670503322, 10188.388696678223, 10206.030427109412, 10210.642627508001, 10224.233182511342, 10224.539895704711, 5483.588730845203, 5490.231367608538, 5511.724413779295, 5522.199281104217, 5525.640833345819, 4165.250254954077, 4441.866743997685, 4582.106489234634, 4831.299461578052, 4983.401991761012, 3933.2920074386884, 4034.092329225901, 4036.6770658347264, 4046.1300820323772, 4094.0379010932406, 1315.2568798628745, 1319.967000824968, 1323.7490571410117, 1331.2079312808862, 1333.7799263121476, 1347.023408029171, 1356.8100465934776, 1360.7006458579096, 1394.9511767088104, 1398.9650258743613, 8279.0, 8366.163383661586, 8425.662973480992, 8426.03100643434, 8445.408821382443, 515.2889013161813, 523.670087844663, 531.5641174237088, 531.614579429918, 531.8989392015504, 5407.972485227794, 6224.844378890564, 6246.094316324107, 6319.273283572356, 6320.5575609706875, 10237.539310731036, 10830.512626931806, 10875.78248435027, 11014.779704405866, 11040.282381645167, 10489.160867130611, 10705.036546710679, 10711.78576428467, 10822.458877056273, 10893.727656808644, 7405.555666660018, 8485.406021578554, 8487.108853570286, 8494.235518803214, 8558.743237702878, 7941.444098913021, 8058.758237252891, 8073.555954422563, 8098.3521318293215, 8122.634481448231, 9717.514124293899, 9747.707568772948, 9749.268804839807, 9795.755106122404, 9935.0, 9920.355176913477, 10108.949455252676, 10123.949380253052, 10227.181825454094, 10250.641227557, 6840.7263709453055, 6857.005734168617, 7231.63841807897, 7679.3856491481665, 7756.806079848049, 8324.334053275603, 8378.371622128487, 8388.874166887379, 8407.15928407179, 8418.915810841812, 7273.454490913097, 7348.853022939618, 7395.186529481645, 7492.962535187289, 7555.848883022419, 7307.963460182665, 7311.23232060626, 7330.523515971445, 7394.223606521453, 7438.330550250504, 7811.609419529114, 7829.217078292353, 7882.014748156481, 7883.881741773764, 7889.960550197212, 7047.647617619201, 7070.823229419306, 7107.466939979418, 7145.39264162552, 7150.284971503016, 7180.60506672138, 7204.279572042754, 7247.710091596488, 7267.491275610657, 7278.381337586365], "unit": "score", "name": "mootools.html", "value": 4888.664895497785}, {"lowerIsBetter": false, "replicates": [320.6697101984956, 325.2356961141318, 328.54168435033114, 332.51784911877775, 333.3532946084594, 6565.474762019039, 6577.967110164454, 6581.506387020974, 6609.636469994149, 6618.735250589983, 6499.252585952617, 6529.053287273355, 6555.606663600187, 6560.343965603437, 6562.737490500374, 4599.40207772989, 4693.507181745918, 4707.293905914106, 4818.614510839142, 4853.611711063115, 4807.495213002637, 4813.951860481403, 4823.589994850442, 4829.710217386951, 4837.443693975185, 4755.239161734124, 4774.546418090275, 4897.877553061184, 4907.6073914086965, 4908.582770464514, 4569.109023740372, 4643.257078867398, 4757.09615173116, 4778.474367819537, 4826.734529600871, 4060.8984775380554, 4061.1268577255737, 4096.508418989741, 4101.651359634435, 4113.938290925638, 6267.937320626781, 6272.027835685476, 6273.0, 6289.182406287154, 6292.339304373067, 5565.526930210896, 5569.721513924328, 5574.637648552831, 5577.079781835992, 5602.439756024406, 5907.734151963172, 6683.732650693966, 6911.2397636259975, 6917.654117294115, 6965.407940325078, 4268.701190916637, 4440.844570440019, 4448.777561121963, 4450.732956022649, 4601.010782681739, 6523.217213934358, 6718.992151177314, 7200.603966781825, 7373.115226172894, 7379.114506259283, 4584.816607335736, 4586.2661974083985, 4588.036512332447, 4588.059447813191, 4593.63250939924, 4608.654350923694, 4627.907441851212, 4641.327007583949, 4643.210654188796, 4651.186042442559, 5297.973510132501, 5521.917171242435, 5527.917081243784, 5528.668279903219, 5535.6955367454375, 5662.490375866192, 5986.311574169026, 6749.156355455568, 6971.407430368374, 7009.7897063088185, 1330.9201447913156, 1587.7221486239862, 1588.5075626555574, 1609.8631616312744, 1611.9032858028556, 1019.37308555238, 1027.209049032241, 1034.3173505486343, 1047.6280920273193, 1047.6909311753052, 5724.971375143097, 6274.61958369158, 6284.214473190851, 6494.155759751202, 6671.766488172891, 7317.292601737391, 7332.486725929134, 7338.486305958639, 7339.743108991266, 7349.228331025272, 6654.633995130217, 6656.667166641649, 6660.467162626978, 6668.433183179484, 6676.232233293136, 3826.8469261229798, 3868.5551161616213, 3870.903227419337, 3874.2832575973534, 3876.4185372193833, 7261.41908647307, 7605.6957721691615, 7632.5038872473115, 7634.465587408939, 7660.770176894702, 7458.477906546598, 7471.0, 7472.514286571464, 7483.289087536676, 7509.249075092447, 7587.355074818703, 7613.1831222446945, 7625.733099341496, 7626.42801789868, 7647.388208943271, 6218.751249949952, 7273.527220730635, 7282.781516554512, 7304.4156467483535, 7307.8538429232185, 7090.822729431806, 7114.466415018791, 7174.390176835028, 7191.928080719126, 7199.928000720135, 7634.4655874088285, 7636.427267954815, 7651.655675494505, 7653.617319134132, 7673.693052278069, 4565.748883811422, 4592.839250626212, 4605.861824145281, 4606.792694328697, 4617.030423610945, 6973.19808222061, 7241.094863142107, 7242.275772422716, 7248.0939882514685, 7249.202587715453, 6645.966770166118, 7021.648917554204, 7067.71729130829, 7218.530795498275, 7227.457940654577, 5310.707911064928, 7003.089598352181, 7020.087388639444, 7023.297670232936, 7027.402670773042, 6861.519693621399, 6864.0, 6875.140607424072, 6880.0367948486255, 6886.690098945459, 6701.832454188684, 7023.719051237893, 7030.261822508767, 7032.789016329519, 7034.331738484836, 6578.5395022347975, 6768.661566921733, 6775.796726098225, 6845.418139458003, 6853.143357080365], "unit": "score", "name": "prototype.html", "value": 5084.756953449198}, {"lowerIsBetter": false, "replicates": [703.2826516952708, 740.210124164279, 747.1072068877693, 747.9925200747991, 810.7284059839953, 14863.033902796311, 15025.624359391008, 15045.849541504582, 15052.247387630601, 15067.020643658168, 13690.726185476284, 13747.93126034371, 13761.17432954021, 13775.0, 13810.585682429542, 737.601695084655, 932.4964519159646, 933.3979583168885, 934.6588495199237, 939.8308304505186, 736.4108713029582, 749.6738918570412, 906.4697152165958, 916.1434059154678, 938.0994245524305, 976.8925418203992, 980.0101897083925, 987.254622759819, 987.2644879564734, 989.1690979577154, 977.8875429325648, 979.3829887171072, 981.1415011864655, 981.1709105805583, 981.4552923127661, 571.0606053042762, 713.7180813578659, 725.5392825555757, 725.9165196002474, 728.231715540105, 14622.415103395851, 14649.19429431381, 14669.70660586793, 14692.70614587713, 14703.485378011825, 12451.501939922393, 12499.93750031244, 12615.684607884785, 12623.431945562472, 12756.234625922381, 10011.299209055369, 10030.448325342104, 10083.344582602182, 10141.492925353703, 10459.94770026145, 3441.0709108540805, 3518.7888726676224, 3568.2007699643937, 3604.2250916052913, 3625.8187090645624, 74266.0, 74266.25733742648, 74308.51382972364, 74421.0, 74460.51078978444, 9171.510540102283, 9481.24150067993, 9498.382605130644, 9588.90411095894, 10333.741656458498, 20872.895635521727, 21033.15867365288, 21089.68365474519, 21095.472613184487, 21115.26096586612, 7442.032535770315, 7580.9620951895995, 7667.501612395176, 7767.02912135983, 7788.961055194801, 4106.67146628269, 4144.0, 4217.1776503581505, 4278.89302767427, 4452.0873220989615, 3629.129009037812, 3694.722895782827, 3701.7038636908983, 3706.610805865399, 3720.2373513429684, 549.9139200079891, 597.1818608506287, 678.6301465701106, 679.1341040173818, 692.7229108356597, 516.651260399229, 579.2672269578986, 595.5057302438966, 604.5012864386898, 604.957652964297, 7965.123836377994, 8155.83688326242, 8212.260896519341, 8289.875651865226, 8584.484930904166, 568.9971550142222, 572.5133636409103, 598.86525531755, 607.492743559133, 617.607819034916, 3819.4652748615217, 3824.464574959508, 3873.96126038736, 3988.6011398859882, 4065.3698676705158, 87121.56439217764, 90629.54685226531, 90952.0, 91057.54471227733, 92110.0, 62615.0, 64394.67802660957, 73866.63066684632, 74400.0, 75378.6231068852, 55742.88514229774, 57028.71485642628, 57108.71445642745, 57354.0, 58639.99999999915, 8116.715914942949, 8319.916800832156, 8389.832203355776, 8391.538465384463, 8417.158284171534, 38678.0, 45946.0, 47249.055018900115, 47510.52489475061, 47566.0, 61924.69037654783, 62981.68509157425, 64159.3960151, 64164.3583564177, 64678.353216467236, 10768.3538987661, 10801.837972430578, 11173.385463799568, 11250.66248012561, 11268.0, 10483.161347092062, 11879.821802672794, 11917.52329906794, 12020.33888136161, 12896.161749486253, 10932.945335273273, 11392.43037848121, 11426.485808138488, 12356.320402377596, 12480.687982800502, 10027.949860250652, 11504.309741415542, 11936.388403285186, 12007.219530730474, 12033.518659253532, 11114.722131946766, 11134.0, 11446.141539384413, 11507.654770356903, 11613.709657258636, 9423.29325300619, 9511.0, 9724.0, 9853.704388868346, 10099.242556808122, 8774.868376974478, 9217.723468295962, 9320.207782338577, 9466.384684995453, 9564.569594368131], "unit": "score", "name": "yui.html", "value": 6824.4629104102705}], "name": "dromaeo_css", "value": 7483.585451502899}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 111.0, 109.0, 111.0, 110.0, 119.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [172.0, 160.0, 147.0, 181.0, 148.0, 142.0, 170.0, 148.0, 195.0, 116.0], "unit": "score", "name": "audio-beat-detection", "value": 157.9}, {"lowerIsBetter": true, "replicates": [385.0, 380.0, 381.0, 384.0, 383.0, 376.0, 379.0, 385.0, 380.0, 382.0], "unit": "score", "name": "audio-dft", "value": 381.5}, {"lowerIsBetter": true, "replicates": [79.0, 75.0, 85.0, 78.0, 56.0, 57.0, 58.0, 81.0, 78.0, 56.0], "unit": "score", "name": "audio-fft", "value": 70.3}, {"lowerIsBetter": true, "replicates": [94.0, 98.0, 129.0, 80.0, 77.0, 89.0, 111.0, 77.0, 84.0, 110.0], "unit": "score", "name": "audio-oscillator", "value": 94.9}, {"lowerIsBetter": true, "replicates": [88.0, 84.0, 87.0, 83.0, 86.0, 84.0, 87.0, 83.0, 86.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.2}, {"lowerIsBetter": true, "replicates": [156.0, 156.0, 157.0, 158.0, 156.0, 155.0, 156.0, 157.0, 156.0, 156.0], "unit": "score", "name": "imaging-darkroom", "value": 156.3}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 84.0, 84.0, 84.0, 86.0, 85.0, 83.0, 85.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 84.5}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 55.0, 53.0, 53.0, 54.0, 55.0, 63.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.2}, {"lowerIsBetter": true, "replicates": [65.0, 72.0, 70.0, 74.0, 71.0, 67.0, 66.0, 67.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 83.0, 83.0, 84.0, 82.0, 83.0, 82.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [134.0, 136.0, 134.0, 109.0, 129.0, 124.0, 119.0, 113.0, 106.0, 139.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.3}, {"lowerIsBetter": true, "replicates": [138.0, 130.0, 174.0, 179.0, 137.0, 129.0, 140.0, 140.0, 174.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 66.0, 67.0, 67.0, 66.0, 66.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1686.8999999999999}]} 03:51:27 INFO - Return code: 0 03:51:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:51:27 ERROR - # TBPL SUCCESS # 03:51:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:51:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:51:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:51:27 INFO - 2016-03-15 03:51:27.870 screenresolution[1703:10046] starting screenresolution argv=screenresolution get 03:51:27 INFO - 2016-03-15 03:51:27.873 screenresolution[1703:10046] Display 0: 1600x1200x32@60 03:51:27 INFO - 2016-03-15 03:51:27.880 screenresolution[1704:10049] starting screenresolution argv=screenresolution list 03:51:27 INFO - Available Modes on Display 0 03:51:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:51:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:51:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:51:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:51:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:51:28 INFO - Intel Iris: 03:51:28 INFO - Chipset Model: Intel Iris 03:51:28 INFO - Type: GPU 03:51:28 INFO - Bus: Built-In 03:51:28 INFO - VRAM (Dynamic, Max): 1536 MB 03:51:28 INFO - Vendor: Intel (0x8086) 03:51:28 INFO - Device ID: 0x0a2e 03:51:28 INFO - Revision ID: 0x0009 03:51:28 INFO - Displays: 03:51:28 INFO - Display: 03:51:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:51:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:51:28 INFO - Display Serial Number: 1600x1200 60 03:51:28 INFO - Main Display: Yes 03:51:28 INFO - Mirror: Off 03:51:28 INFO - Online: Yes 03:51:28 INFO - Rotation: Supported 03:51:28 INFO - Return code: 0 03:51:28 INFO - Running post-action listener: _resource_record_post_action 03:51:28 INFO - Running post-run listener: _resource_record_post_run 03:51:29 INFO - Total resource usage - Wall time: 1210s; CPU: 52.0%; Read bytes: 34070016; Write bytes: 707868160; Read time: 412; Write time: 2165 03:51:29 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 393839104; Write bytes: 390553088; Read time: 29510; Write time: 797 03:51:29 INFO - run-tests - Wall time: 1176s; CPU: 52.0%; Read bytes: 32271872; Write bytes: 299116544; Read time: 393; Write time: 1324 03:51:29 INFO - Running post-run listener: _upload_blobber_files 03:51:29 INFO - Blob upload gear active. 03:51:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:51:29 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 03:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:51:29 INFO - (blobuploader) - INFO - Open directory for files ... 03:51:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:51:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:51:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:30 INFO - (blobuploader) - INFO - Done attempting. 03:51:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:51:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:51:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:31 INFO - (blobuploader) - INFO - Done attempting. 03:51:31 INFO - (blobuploader) - INFO - Iteration through files over. 03:51:31 INFO - Return code: 0 03:51:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:51:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:51:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d41b31b6b228018e3a6ef8668d02fc42d0e55681221d1706ffaddbbcb3e1b98d69f85ded1bb4f7c66c545b3ce01c574e441c57fb947bb1664c40bcf0e557973e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53b2ad291dc21c8a8e240d21f9ef3ab1e78b230571c17748caf3f241fba0ce6426ee9fbc440560660b73720346578a8d2bb216a7b23d0f1a9f5b4c9c90d269c2"} 03:51:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:51:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:51:31 INFO - Contents: 03:51:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d41b31b6b228018e3a6ef8668d02fc42d0e55681221d1706ffaddbbcb3e1b98d69f85ded1bb4f7c66c545b3ce01c574e441c57fb947bb1664c40bcf0e557973e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53b2ad291dc21c8a8e240d21f9ef3ab1e78b230571c17748caf3f241fba0ce6426ee9fbc440560660b73720346578a8d2bb216a7b23d0f1a9f5b4c9c90d269c2"} 03:51:31 INFO - Running post-run listener: copy_logs_to_upload_dir 03:51:31 INFO - Copying logs to upload dir... 03:51:31 INFO - mkdir: /builds/slave/test/build/upload/logs 03:51:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.458760 ========= master_lag: 9.18 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-03-15 03:51:40.846933) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-03-15 03:51:40.851231) ========= 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.FTMVNDGTjI/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.bLKaEjebBY/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d41b31b6b228018e3a6ef8668d02fc42d0e55681221d1706ffaddbbcb3e1b98d69f85ded1bb4f7c66c545b3ce01c574e441c57fb947bb1664c40bcf0e557973e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53b2ad291dc21c8a8e240d21f9ef3ab1e78b230571c17748caf3f241fba0ce6426ee9fbc440560660b73720346578a8d2bb216a7b23d0f1a9f5b4c9c90d269c2"} build_url:https://queue.taskcluster.net/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011448 build_url: 'https://queue.taskcluster.net/v1/task/IiCrVU7LRN6GfQ4Xjg_NFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d41b31b6b228018e3a6ef8668d02fc42d0e55681221d1706ffaddbbcb3e1b98d69f85ded1bb4f7c66c545b3ce01c574e441c57fb947bb1664c40bcf0e557973e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53b2ad291dc21c8a8e240d21f9ef3ab1e78b230571c17748caf3f241fba0ce6426ee9fbc440560660b73720346578a8d2bb216a7b23d0f1a9f5b4c9c90d269c2"}' ========= master_lag: 2.37 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-03-15 03:51:43.230714) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 03:51:43.231021) ========= 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.FTMVNDGTjI/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.bLKaEjebBY/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.005157 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 03:51:43.313471) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 03:51:43.313794) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 03:51:43.328858) ========= ========= Total master_lag: 48.36 =========