builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0163 starttime: 1459919018.51 results: success (0) buildid: 20160405205220 builduid: 6e383595c079482191de7c9ee5d6f12d revision: e003ad2de364adc21bd7ed89715bc6f397ba9739 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:38.513315) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:38.513734) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:38.514022) ========= 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.KRvsnaa25I/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.DOHWQjpfId/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.005523 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:38.553590) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:38.556888) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:38.591012) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:38.591274) ========= 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.KRvsnaa25I/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.DOHWQjpfId/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.004857 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:38.647583) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:38.647857) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:38.648175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:38.648447) ========= 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.KRvsnaa25I/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.DOHWQjpfId/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-05 22:03:38-- 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% 147M=0s 2016-04-05 22:03:38 (147 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.216461 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:38.887960) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:38.888269) ========= 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.KRvsnaa25I/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.DOHWQjpfId/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.024191 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:38.950257) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-05 22:03:38.950565) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e003ad2de364adc21bd7ed89715bc6f397ba9739 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e003ad2de364adc21bd7ed89715bc6f397ba9739 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KRvsnaa25I/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.DOHWQjpfId/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-05 22:03:39,024 truncating revision to first 12 chars 2016-04-05 22:03:39,024 Setting DEBUG logging. 2016-04-05 22:03:39,024 attempt 1/10 2016-04-05 22:03:39,024 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e003ad2de364?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-05 22:03:39,873 unpacking tar archive at: fx-team-e003ad2de364/testing/mozharness/ program finished with exit code 0 elapsedTime=1.081676 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-05 22:03:40.050843) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:40.051177) ========= echo e003ad2de364adc21bd7ed89715bc6f397ba9739 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e003ad2de364adc21bd7ed89715bc6f397ba9739'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KRvsnaa25I/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.DOHWQjpfId/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 e003ad2de364adc21bd7ed89715bc6f397ba9739 program finished with exit code 0 elapsedTime=0.005454 script_repo_revision: 'e003ad2de364adc21bd7ed89715bc6f397ba9739' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:40.100582) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:40.103911) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:40.119020) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-04-05 22:03:40.119297) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KRvsnaa25I/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.DOHWQjpfId/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 22:03:40 INFO - MultiFileLogger online at 20160405 22:03:40 in /builds/slave/test 22:03:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:03:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:03:40 INFO - {'append_to_log': False, 22:03:40 INFO - 'base_work_dir': '/builds/slave/test', 22:03:40 INFO - 'blob_upload_branch': 'Fx-Team', 22:03:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:03:40 INFO - 'branch': 'Fx-Team', 22:03:40 INFO - 'buildbot_json_path': 'buildprops.json', 22:03:40 INFO - 'config_files': ('talos/mac_config.py',), 22:03:40 INFO - 'default_actions': ('clobber', 22:03:40 INFO - 'read-buildbot-config', 22:03:40 INFO - 'download-and-extract', 22:03:40 INFO - 'populate-webroot', 22:03:40 INFO - 'create-virtualenv', 22:03:40 INFO - 'install', 22:03:40 INFO - 'run-tests'), 22:03:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:03:40 INFO - 'download_minidump_stackwalk': True, 22:03:40 INFO - 'download_symbols': 'ondemand', 22:03:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:03:40 INFO - 'tooltool.py': '/tools/tooltool.py', 22:03:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:03:40 INFO - '/tools/misc-python/virtualenv.py')}, 22:03:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:03:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:03:40 INFO - 'installer_path': 'installer.exe', 22:03:40 INFO - 'log_level': 'info', 22:03:40 INFO - 'log_name': 'talos', 22:03:40 INFO - 'log_to_console': True, 22:03:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:03:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:03:40 INFO - 'opt_config_files': (), 22:03:40 INFO - 'pip_index': False, 22:03:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:03:40 INFO - 'cmd': ('bash', 22:03:40 INFO - '-c', 22:03:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:03:40 INFO - 'enabled': True, 22:03:40 INFO - 'halt_on_failure': False, 22:03:40 INFO - 'name': 'check_screen_resolution'},), 22:03:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:03:40 INFO - 'cmd': ('bash', 22:03:40 INFO - '-c', 22:03:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:03:40 INFO - 'enabled': True, 22:03:40 INFO - 'halt_on_failure': False, 22:03:40 INFO - 'name': 'check_screen_resolution'},), 22:03:40 INFO - 'run_cmd_checks_enabled': True, 22:03:40 INFO - 'sps_profile': False, 22:03:40 INFO - 'sps_profile_interval': 0, 22:03:40 INFO - 'suite': 'dromaeojs', 22:03:40 INFO - 'system_bits': '32', 22:03:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:03:40 INFO - 'title': 't-yosemite-r7-0163', 22:03:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:03:40 INFO - 'use_talos_json': True, 22:03:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:03:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:03:40 INFO - 'work_dir': 'build'} 22:03:40 INFO - ##### 22:03:40 INFO - ##### Running clobber step. 22:03:40 INFO - ##### 22:03:40 INFO - Running pre-action listener: _resource_record_pre_action 22:03:40 INFO - Running main action method: clobber 22:03:40 INFO - rmtree: /builds/slave/test/build 22:03:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:03:41 INFO - Running post-action listener: _resource_record_post_action 22:03:41 INFO - ##### 22:03:41 INFO - ##### Running read-buildbot-config step. 22:03:41 INFO - ##### 22:03:41 INFO - Running pre-action listener: _resource_record_pre_action 22:03:41 INFO - Running main action method: read_buildbot_config 22:03:41 INFO - Using buildbot properties: 22:03:41 INFO - { 22:03:41 INFO - "project": "", 22:03:41 INFO - "product": "firefox", 22:03:41 INFO - "script_repo_revision": "production", 22:03:41 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 22:03:41 INFO - "repository": "", 22:03:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 22:03:41 INFO - "buildid": "20160405205220", 22:03:41 INFO - "pgo_build": "False", 22:03:41 INFO - "basedir": "/builds/slave/test", 22:03:41 INFO - "buildnumber": 680, 22:03:41 INFO - "slavename": "t-yosemite-r7-0163", 22:03:41 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 22:03:41 INFO - "platform": "yosemite_r7", 22:03:41 INFO - "scheduler": "tests-fx-team-macosx64-talos", 22:03:41 INFO - "branch": "fx-team", 22:03:41 INFO - "repo_path": "integration/fx-team", 22:03:41 INFO - "revision": "e003ad2de364adc21bd7ed89715bc6f397ba9739", 22:03:41 INFO - "stage_platform": "macosx64", 22:03:41 INFO - "builduid": "6e383595c079482191de7c9ee5d6f12d", 22:03:41 INFO - "slavebuilddir": "test" 22:03:41 INFO - } 22:03:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 22:03:41 INFO - Running post-action listener: _resource_record_post_action 22:03:41 INFO - ##### 22:03:41 INFO - ##### Running download-and-extract step. 22:03:41 INFO - ##### 22:03:41 INFO - Running pre-action listener: _resource_record_pre_action 22:03:41 INFO - Running main action method: download_and_extract 22:03:41 INFO - mkdir: /builds/slave/test/build/tests 22:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:03:41 INFO - https://queue.taskcluster.net/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 22:03:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 22:03:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 22:03:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AGqzypb6TIy9CN2OJ76wGQ/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 22:03:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AGqzypb6TIy9CN2OJ76wGQ/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 22:03:43 INFO - Downloaded 1199 bytes. 22:03:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 22:03:43 INFO - Using the following test package requirements: 22:03:43 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 22:03:43 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:03:43 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 22:03:43 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:03:43 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 22:03:43 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:03:43 INFO - u'jsshell-mac.zip'], 22:03:43 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:03:43 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 22:03:43 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 22:03:43 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:03:43 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 22:03:43 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:03:43 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 22:03:43 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:03:43 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 22:03:43 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:03:43 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 22:03:43 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:03:43 INFO - https://queue.taskcluster.net/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:03:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:03:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:03:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AGqzypb6TIy9CN2OJ76wGQ/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 22:03:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AGqzypb6TIy9CN2OJ76wGQ/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 22:03:45 INFO - Downloaded 17959868 bytes. 22:03:45 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'] 22:03:45 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 22:03:49 INFO - Return code: 0 22:03:49 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 22:03:49 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')]} 22:03:49 INFO - https://queue.taskcluster.net/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:03:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:03:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:03:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AGqzypb6TIy9CN2OJ76wGQ/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 22:03:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AGqzypb6TIy9CN2OJ76wGQ/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 22:03:50 INFO - Downloaded 17959868 bytes. 22:03:50 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'] 22:03:50 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 22:03:54 INFO - Return code: 0 22:03:54 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')]} 22:03:54 INFO - https://queue.taskcluster.net/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 22:03:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 22:03:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 22:03:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AGqzypb6TIy9CN2OJ76wGQ/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 22:03:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AGqzypb6TIy9CN2OJ76wGQ/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 22:03:56 INFO - Downloaded 10847584 bytes. 22:03:56 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'] 22:03:56 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 22:03:56 INFO - Return code: 0 22:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:03:56 INFO - https://queue.taskcluster.net/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 22:03:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:03:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:03:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 22:03:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AGqzypb6TIy9CN2OJ76wGQ/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 22:04:02 INFO - Downloaded 111336665 bytes. 22:04:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:04:02 INFO - mkdir: /builds/slave/test/properties 22:04:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:04:02 INFO - Writing to file /builds/slave/test/properties/build_url 22:04:02 INFO - Contents: 22:04:02 INFO - build_url:https://queue.taskcluster.net/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:04:03 INFO - Running post-action listener: _resource_record_post_action 22:04:03 INFO - Running post-action listener: set_extra_try_arguments 22:04:03 INFO - ##### 22:04:03 INFO - ##### Running populate-webroot step. 22:04:03 INFO - ##### 22:04:03 INFO - Running pre-action listener: _resource_record_pre_action 22:04:03 INFO - Running main action method: populate_webroot 22:04:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:04:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:04:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:04:03 INFO - '--tppagecycles', 22:04:03 INFO - '7'], 22:04:03 INFO - 'tests': ['tsvgm']}}, 22:04:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:04:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:04:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:04:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:04:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:04:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:04:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:04:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:03 INFO - 'talos_options': ['--e10s'], 22:04:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:04:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:03 INFO - 'tests': ['damp', 'tps']}, 22:04:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:03 INFO - 'talos_options': ['--e10s'], 22:04:03 INFO - 'tests': ['damp', 'tps']}, 22:04:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:04:03 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 22:04:03 INFO - 'tests': ['dromaeo_dom']}, 22:04:03 INFO - 'other': {'tests': ['a11yr', 22:04:03 INFO - 'ts_paint', 22:04:03 INFO - 'tpaint', 22:04:03 INFO - 'sessionrestore', 22:04:03 INFO - 'sessionrestore_no_auto_restore', 22:04:03 INFO - 'tabpaint']}, 22:04:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:04:03 INFO - 'tests': ['a11yr', 22:04:03 INFO - 'ts_paint', 22:04:03 INFO - 'tpaint', 22:04:03 INFO - 'sessionrestore', 22:04:03 INFO - 'sessionrestore_no_auto_restore', 22:04:03 INFO - 'tabpaint']}, 22:04:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:04:03 INFO - 'tests': ['a11yr', 22:04:03 INFO - 'ts_paint', 22:04:03 INFO - 'tpaint', 22:04:03 INFO - 'sessionrestore', 22:04:03 INFO - 'sessionrestore_no_auto_restore', 22:04:03 INFO - 'tabpaint']}, 22:04:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:04:03 INFO - 'tests': ['a11yr', 22:04:03 INFO - 'ts_paint', 22:04:03 INFO - 'tpaint', 22:04:03 INFO - 'sessionrestore', 22:04:03 INFO - 'sessionrestore_no_auto_restore', 22:04:03 INFO - 'tabpaint']}, 22:04:03 INFO - 'other_l64': {'tests': ['a11yr', 22:04:03 INFO - 'ts_paint', 22:04:03 INFO - 'tpaint', 22:04:03 INFO - 'sessionrestore', 22:04:03 INFO - 'sessionrestore_no_auto_restore', 22:04:03 INFO - 'tabpaint']}, 22:04:03 INFO - 'other_nol64': {'tests': ['a11yr', 22:04:03 INFO - 'ts_paint', 22:04:03 INFO - 'tpaint', 22:04:03 INFO - 'sessionrestore', 22:04:03 INFO - 'sessionrestore_no_auto_restore', 22:04:03 INFO - 'tabpaint']}, 22:04:03 INFO - 'svgr': {'tests': ['tsvgx', 22:04:03 INFO - 'tsvgr_opacity', 22:04:03 INFO - 'tart', 22:04:03 INFO - 'tscrollx', 22:04:03 INFO - 'cart']}, 22:04:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:04:03 INFO - 'tests': ['tsvgx', 22:04:03 INFO - 'tsvgr_opacity', 22:04:03 INFO - 'tart', 22:04:03 INFO - 'tscrollx', 22:04:03 INFO - 'cart']}, 22:04:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:03 INFO - 'tests': ['tp5o']}, 22:04:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:03 INFO - 'talos_options': ['--e10s'], 22:04:03 INFO - 'tests': ['tp5o']}, 22:04:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:03 INFO - 'talos_options': ['--xperf_path', 22:04:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:04:03 INFO - 'tests': ['tp5n']}, 22:04:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:03 INFO - 'talos_options': ['--e10s', 22:04:03 INFO - '--xperf_path', 22:04:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:04:03 INFO - 'tests': ['tp5n']}}, 22:04:03 INFO - 'talos.zip': {'path': '', 22:04:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:04:03 INFO - Running post-action listener: _resource_record_post_action 22:04:03 INFO - ##### 22:04:03 INFO - ##### Running create-virtualenv step. 22:04:03 INFO - ##### 22:04:03 INFO - Running pre-action listener: _resource_record_pre_action 22:04:03 INFO - Running main action method: create_virtualenv 22:04:03 INFO - Creating virtualenv /builds/slave/test/build/venv 22:04:03 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 22:04:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:04:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:04:03 INFO - Using real prefix '/tools/python27' 22:04:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:04:04 INFO - Installing distribute.............................................................................................................................................................................................done. 22:04:07 INFO - Installing pip.................done. 22:04:07 INFO - Return code: 0 22:04:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:07 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 0x10efcda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efdd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae91cb6f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee6ce00>, '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 0x10ec95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee67b20>, '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.KRvsnaa25I/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.DOHWQjpfId/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 22:04:07 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 22:04:07 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 22:04:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRvsnaa25I/Render', 22:04:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:04:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:04:07 INFO - 'HOME': '/Users/cltbld', 22:04:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:04:07 INFO - 'LOGNAME': 'cltbld', 22:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:07 INFO - 'MOZ_NO_REMOTE': '1', 22:04:07 INFO - 'NO_EM_RESTART': '1', 22:04:07 INFO - 'PAGER': '/bin/cat', 22:04:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:07 INFO - 'PWD': '/builds/slave/test', 22:04:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:04:07 INFO - 'SHELL': '/bin/bash', 22:04:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOHWQjpfId/Listeners', 22:04:07 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 22:04:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:04:07 INFO - 'USER': 'cltbld', 22:04:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:04:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:07 INFO - 'XPC_FLAGS': '0x0', 22:04:07 INFO - 'XPC_SERVICE_NAME': '0', 22:04:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:04:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:07 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 22:04:07 INFO - Cleaning up... 22:04:07 INFO - Return code: 0 22:04:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:07 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 0x10efcda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efdd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae91cb6f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee6ce00>, '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 0x10ec95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee67b20>, '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.KRvsnaa25I/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.DOHWQjpfId/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 22:04:07 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 22:04:07 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 22:04:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRvsnaa25I/Render', 22:04:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:04:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:04:07 INFO - 'HOME': '/Users/cltbld', 22:04:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:04:07 INFO - 'LOGNAME': 'cltbld', 22:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:07 INFO - 'MOZ_NO_REMOTE': '1', 22:04:07 INFO - 'NO_EM_RESTART': '1', 22:04:07 INFO - 'PAGER': '/bin/cat', 22:04:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:07 INFO - 'PWD': '/builds/slave/test', 22:04:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:04:07 INFO - 'SHELL': '/bin/bash', 22:04:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOHWQjpfId/Listeners', 22:04:07 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 22:04:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:04:07 INFO - 'USER': 'cltbld', 22:04:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:04:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:07 INFO - 'XPC_FLAGS': '0x0', 22:04:07 INFO - 'XPC_SERVICE_NAME': '0', 22:04:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:04:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:07 INFO - Downloading/unpacking psutil>=0.7.1 22:04:07 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 22:04:07 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 22:04:07 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 22:04:07 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 22:04:07 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 22:04:07 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 22:04:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:04:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:04:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:04:10 INFO - Installing collected packages: psutil 22:04:10 INFO - Running setup.py install for psutil 22:04:10 INFO - building 'psutil._psutil_osx' extension 22:04:10 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 22:04:11 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 22:04:11 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 22:04:11 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 22:04:11 INFO - building 'psutil._psutil_posix' extension 22:04:11 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 22:04:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:04:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:04:11 INFO - ^ 22:04:11 INFO - 1 warning generated. 22:04:11 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 22:04:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:04:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:04:12 INFO - Successfully installed psutil 22:04:12 INFO - Cleaning up... 22:04:12 INFO - Return code: 0 22:04:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:12 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 0x10efcda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efdd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae91cb6f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee6ce00>, '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 0x10ec95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee67b20>, '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.KRvsnaa25I/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.DOHWQjpfId/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 22:04:12 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 22:04:12 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 22:04:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRvsnaa25I/Render', 22:04:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:04:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:04:12 INFO - 'HOME': '/Users/cltbld', 22:04:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:04:12 INFO - 'LOGNAME': 'cltbld', 22:04:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:12 INFO - 'MOZ_NO_REMOTE': '1', 22:04:12 INFO - 'NO_EM_RESTART': '1', 22:04:12 INFO - 'PAGER': '/bin/cat', 22:04:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:04:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:12 INFO - 'PWD': '/builds/slave/test', 22:04:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:04:12 INFO - 'SHELL': '/bin/bash', 22:04:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOHWQjpfId/Listeners', 22:04:12 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 22:04:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:04:12 INFO - 'USER': 'cltbld', 22:04:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:04:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:04:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:12 INFO - 'XPC_FLAGS': '0x0', 22:04:12 INFO - 'XPC_SERVICE_NAME': '0', 22:04:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:04:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:04: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 22:04: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 22:04: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 22:04: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 22:04: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 22:04: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 22:04:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:04:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:04:14 INFO - Installing collected packages: mozsystemmonitor 22:04:14 INFO - Running setup.py install for mozsystemmonitor 22:04:15 INFO - Successfully installed mozsystemmonitor 22:04:15 INFO - Cleaning up... 22:04:15 INFO - Return code: 0 22:04:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:15 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 0x10efcda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efdd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae91cb6f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee6ce00>, '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 0x10ec95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee67b20>, '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.KRvsnaa25I/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.DOHWQjpfId/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 22:04:15 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 22:04:15 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 22:04:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRvsnaa25I/Render', 22:04:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:04:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:04:15 INFO - 'HOME': '/Users/cltbld', 22:04:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:04:15 INFO - 'LOGNAME': 'cltbld', 22:04:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:15 INFO - 'MOZ_NO_REMOTE': '1', 22:04:15 INFO - 'NO_EM_RESTART': '1', 22:04:15 INFO - 'PAGER': '/bin/cat', 22:04:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:04:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:15 INFO - 'PWD': '/builds/slave/test', 22:04:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:04:15 INFO - 'SHELL': '/bin/bash', 22:04:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOHWQjpfId/Listeners', 22:04:15 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 22:04:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:04:15 INFO - 'USER': 'cltbld', 22:04:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:04:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:04:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:15 INFO - 'XPC_FLAGS': '0x0', 22:04:15 INFO - 'XPC_SERVICE_NAME': '0', 22:04:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:04:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:15 INFO - Downloading/unpacking blobuploader==1.2.4 22:04: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 22:04: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 22:04: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 22:04: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 22:04: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 22:04: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 22:04:17 INFO - Downloading blobuploader-1.2.4.tar.gz 22:04:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:04:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:04:18 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 22:04:18 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 22:04:18 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 22:04:18 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 22:04:18 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 22:04:18 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 22:04:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:04:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:04:18 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 22:04:18 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 22:04:18 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 22:04:18 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 22:04:18 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 22:04:18 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 22:04:19 INFO - Downloading docopt-0.6.1.tar.gz 22:04:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:04:19 INFO - Installing collected packages: blobuploader, requests, docopt 22:04:19 INFO - Running setup.py install for blobuploader 22:04:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:04:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:04:19 INFO - Running setup.py install for requests 22:04:19 INFO - Running setup.py install for docopt 22:04:20 INFO - Successfully installed blobuploader requests docopt 22:04:20 INFO - Cleaning up... 22:04:20 INFO - Return code: 0 22:04:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:04:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:20 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 0x10efcda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efdd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae91cb6f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee6ce00>, '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 0x10ec95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee67b20>, '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.KRvsnaa25I/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.DOHWQjpfId/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 22:04:20 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 22:04:20 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 22:04:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRvsnaa25I/Render', 22:04:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:04:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:04:20 INFO - 'HOME': '/Users/cltbld', 22:04:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:04:20 INFO - 'LOGNAME': 'cltbld', 22:04:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:20 INFO - 'MOZ_NO_REMOTE': '1', 22:04:20 INFO - 'NO_EM_RESTART': '1', 22:04:20 INFO - 'PAGER': '/bin/cat', 22:04:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:04:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:20 INFO - 'PWD': '/builds/slave/test', 22:04:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:04:20 INFO - 'SHELL': '/bin/bash', 22:04:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOHWQjpfId/Listeners', 22:04:20 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 22:04:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:04:20 INFO - 'USER': 'cltbld', 22:04:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:04:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:04:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:20 INFO - 'XPC_FLAGS': '0x0', 22:04:20 INFO - 'XPC_SERVICE_NAME': '0', 22:04:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:04:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:04:20 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-aLQCN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:04:20 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-h1LO9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:04:20 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-5du1UD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:04:20 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-d8XT85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:04:20 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-34TG3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:04:20 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-H5cKnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:04:21 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-XlRU18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:04:21 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-srAE5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:04:21 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-3Hz5fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:04:21 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-YyL3Jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:04:21 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-9uycED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:04:21 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-hJ6_Sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:04:21 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-pTruAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:04:21 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-0yhmV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:04:21 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-aVIyJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:04:21 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-FkcYS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:04:22 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-WxlDjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:04:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:04:22 INFO - Running setup.py install for manifestparser 22:04:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:04:22 INFO - Running setup.py install for mozcrash 22:04:22 INFO - Running setup.py install for mozdebug 22:04:22 INFO - Running setup.py install for mozdevice 22:04:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:04:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:04:22 INFO - Running setup.py install for mozfile 22:04:22 INFO - Running setup.py install for mozhttpd 22:04:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:04:23 INFO - Running setup.py install for mozinfo 22:04:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:04:23 INFO - Running setup.py install for mozInstall 22:04:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:04:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:04:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:04:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:04:23 INFO - Running setup.py install for mozleak 22:04:23 INFO - Running setup.py install for mozlog 22:04:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:04:23 INFO - Running setup.py install for moznetwork 22:04:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:04:23 INFO - Running setup.py install for mozprocess 22:04:23 INFO - Running setup.py install for mozprofile 22:04:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:04:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:04:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:04:24 INFO - Running setup.py install for mozrunner 22:04:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:04:24 INFO - Running setup.py install for mozscreenshot 22:04:24 INFO - Running setup.py install for moztest 22:04:24 INFO - Running setup.py install for mozversion 22:04:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:04:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:04:24 INFO - Cleaning up... 22:04:24 INFO - Return code: 0 22:04:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:04: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')]} 22:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04: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')]} 22:04:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:24 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 0x10efcda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efdd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae91cb6f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee6ce00>, '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 0x10ec95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee67b20>, '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.KRvsnaa25I/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.DOHWQjpfId/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 22:04:24 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 22:04:24 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 22:04:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRvsnaa25I/Render', 22:04:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:04:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:04:24 INFO - 'HOME': '/Users/cltbld', 22:04:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:04:24 INFO - 'LOGNAME': 'cltbld', 22:04:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:24 INFO - 'MOZ_NO_REMOTE': '1', 22:04:24 INFO - 'NO_EM_RESTART': '1', 22:04:24 INFO - 'PAGER': '/bin/cat', 22:04:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:04:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:24 INFO - 'PWD': '/builds/slave/test', 22:04:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:04:24 INFO - 'SHELL': '/bin/bash', 22:04:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOHWQjpfId/Listeners', 22:04:24 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 22:04:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:04:24 INFO - 'USER': 'cltbld', 22:04:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:04:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:04:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:24 INFO - 'XPC_FLAGS': '0x0', 22:04:24 INFO - 'XPC_SERVICE_NAME': '0', 22:04:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:04:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:04:25 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-NFnIQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:04:25 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)) 22:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:04:25 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-RiZToT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:04:25 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)) 22:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:04:25 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-YjbOST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:04:25 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)) 22:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:04:25 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-UqKeKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:04:25 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)) 22:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:04:25 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-2ONnlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:04:25 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)) 22:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:04:25 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-nfbCIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:04:25 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)) 22:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:04:25 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-9pcygM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:04:25 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)) 22:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:04:25 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-30dYFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:04:25 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)) 22:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:04:25 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Pq4TtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:04:26 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)) 22:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:04:26 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-8dIhFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:04:26 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)) 22:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:04:26 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-2yq7UJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:04:26 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)) 22:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:04:26 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ruxKup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:04:26 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)) 22:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:04:26 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-vvenZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:04:26 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)) 22:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:04:26 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-3nTdnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:04:26 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)) 22:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:04:26 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-aMxGZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:04:26 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)) 22:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:04:26 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-8I86Qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:04:26 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)) 22:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:04:26 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-dExC3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:04:26 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)) 22:04:26 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)) 22:04:26 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)) 22:04:26 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)) 22:04:26 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)) 22:04:26 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)) 22:04:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:29 INFO - Downloading blessings-1.6.tar.gz 22:04:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:04:29 INFO - Installing collected packages: blessings 22:04:29 INFO - Running setup.py install for blessings 22:04:29 INFO - Successfully installed blessings 22:04:29 INFO - Cleaning up... 22:04:29 INFO - Return code: 0 22:04:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:04:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:04:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:04:30 INFO - Reading from file tmpfile_stdout 22:04:30 INFO - Current package versions: 22:04:30 INFO - blessings == 1.6 22:04:30 INFO - blobuploader == 1.2.4 22:04:30 INFO - docopt == 0.6.1 22:04:30 INFO - manifestparser == 1.1 22:04:30 INFO - mozInstall == 1.12 22:04:30 INFO - mozcrash == 0.17 22:04:30 INFO - mozdebug == 0.1 22:04:30 INFO - mozdevice == 0.48 22:04:30 INFO - mozfile == 1.2 22:04:30 INFO - mozhttpd == 0.7 22:04:30 INFO - mozinfo == 0.9 22:04:30 INFO - mozleak == 0.1 22:04:30 INFO - mozlog == 3.1 22:04:30 INFO - moznetwork == 0.27 22:04:30 INFO - mozprocess == 0.22 22:04:30 INFO - mozprofile == 0.28 22:04:30 INFO - mozrunner == 6.11 22:04:30 INFO - mozscreenshot == 0.1 22:04:30 INFO - mozsystemmonitor == 0.0 22:04:30 INFO - moztest == 0.7 22:04:30 INFO - mozversion == 1.4 22:04:30 INFO - psutil == 3.1.1 22:04:30 INFO - requests == 1.2.3 22:04:30 INFO - wsgiref == 0.1.2 22:04:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:30 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 0x10efcda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efdd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae91cb6f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee6ce00>, '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 0x10ec95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee67b20>, '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.KRvsnaa25I/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.DOHWQjpfId/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 22:04:30 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 22:04:30 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 22:04:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRvsnaa25I/Render', 22:04:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:04:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:04:30 INFO - 'HOME': '/Users/cltbld', 22:04:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:04:30 INFO - 'LOGNAME': 'cltbld', 22:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:30 INFO - 'MOZ_NO_REMOTE': '1', 22:04:30 INFO - 'NO_EM_RESTART': '1', 22:04:30 INFO - 'PAGER': '/bin/cat', 22:04:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:30 INFO - 'PWD': '/builds/slave/test', 22:04:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:04:30 INFO - 'SHELL': '/bin/bash', 22:04:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOHWQjpfId/Listeners', 22:04:30 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 22:04:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:04:30 INFO - 'USER': 'cltbld', 22:04:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:04:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:30 INFO - 'XPC_FLAGS': '0x0', 22:04:30 INFO - 'XPC_SERVICE_NAME': '0', 22:04:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:30 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)) 22:04:30 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)) 22:04:30 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)) 22:04:30 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)) 22:04:30 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)) 22:04:30 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)) 22:04:30 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)) 22:04:30 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)) 22:04:30 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)) 22:04:30 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)) 22:04:30 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)) 22:04:30 INFO - Cleaning up... 22:04:30 INFO - Return code: 0 22:04:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10efcda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efdd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae91cb6f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee6ce00>, '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 0x10ec95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee67b20>, '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.KRvsnaa25I/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.DOHWQjpfId/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 22:04:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:04:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:04:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRvsnaa25I/Render', 22:04:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:04:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:04:30 INFO - 'HOME': '/Users/cltbld', 22:04:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:04:30 INFO - 'LOGNAME': 'cltbld', 22:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:30 INFO - 'MOZ_NO_REMOTE': '1', 22:04:30 INFO - 'NO_EM_RESTART': '1', 22:04:30 INFO - 'PAGER': '/bin/cat', 22:04:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:30 INFO - 'PWD': '/builds/slave/test', 22:04:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:04:30 INFO - 'SHELL': '/bin/bash', 22:04:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOHWQjpfId/Listeners', 22:04:30 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 22:04:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:04:30 INFO - 'USER': 'cltbld', 22:04:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:04:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:30 INFO - 'XPC_FLAGS': '0x0', 22:04:30 INFO - 'XPC_SERVICE_NAME': '0', 22:04:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:30 INFO - Downloading/unpacking jsonschema 22:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:04:33 INFO - Downloading/unpacking functools32 (from jsonschema) 22:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:33 INFO - Downloading functools32-3.2.3-2.tar.gz 22:04:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:04:34 INFO - warning: no files found matching '*.txt' 22:04:34 INFO - no previously-included directories found matching 'build' 22:04:34 INFO - no previously-included directories found matching 'dist' 22:04:34 INFO - no previously-included directories found matching '.git*' 22:04:34 INFO - Installing collected packages: jsonschema, functools32 22:04:34 INFO - Running setup.py install for functools32 22:04:34 INFO - warning: no files found matching '*.txt' 22:04:34 INFO - no previously-included directories found matching 'build' 22:04:34 INFO - no previously-included directories found matching 'dist' 22:04:34 INFO - no previously-included directories found matching '.git*' 22:04:34 INFO - Successfully installed jsonschema functools32 22:04:34 INFO - Cleaning up... 22:04:34 INFO - Return code: 0 22:04:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:34 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 0x10efcda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efdd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae91cb6f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee6ce00>, '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 0x10ec95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee67b20>, '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.KRvsnaa25I/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.DOHWQjpfId/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 22:04:34 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 22:04:34 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 22:04:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRvsnaa25I/Render', 22:04:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:04:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:04:34 INFO - 'HOME': '/Users/cltbld', 22:04:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:04:34 INFO - 'LOGNAME': 'cltbld', 22:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:34 INFO - 'MOZ_NO_REMOTE': '1', 22:04:34 INFO - 'NO_EM_RESTART': '1', 22:04:34 INFO - 'PAGER': '/bin/cat', 22:04:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:04:34 INFO - 'PWD': '/builds/slave/test', 22:04:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:04:34 INFO - 'SHELL': '/bin/bash', 22:04:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOHWQjpfId/Listeners', 22:04:34 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 22:04:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:04:34 INFO - 'USER': 'cltbld', 22:04:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:04:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:34 INFO - 'XPC_FLAGS': '0x0', 22:04:34 INFO - 'XPC_SERVICE_NAME': '0', 22:04:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:04:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:34 INFO - Downloading/unpacking flake8 22:04:34 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 22:04:34 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 22:04:34 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 22:04:34 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 22:04:34 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 22:04:34 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 22:04:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:04:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:04:37 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 22:04:37 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 22:04:37 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 22:04:37 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 22:04:37 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 22:04:37 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 22:04:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:04:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:04:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:04:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:04:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:04:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:04:39 INFO - no previously-included directories found matching 'docs/_build' 22:04:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:04:39 INFO - Running setup.py install for pep8 22:04:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:04:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:04:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:04:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:04:39 INFO - no previously-included directories found matching 'docs/_build' 22:04:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:04:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:04:39 INFO - Cleaning up... 22:04:39 INFO - Return code: 0 22:04:39 INFO - Running post-action listener: _resource_record_post_action 22:04:39 INFO - Running post-action listener: _start_resource_monitoring 22:04:39 INFO - Starting resource monitoring. 22:04:39 INFO - ##### 22:04:39 INFO - ##### Running install step. 22:04:39 INFO - ##### 22:04:39 INFO - Running pre-action listener: _resource_record_pre_action 22:04:39 INFO - Running main action method: install 22:04:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:04:39 INFO - Reading from file tmpfile_stdout 22:04:39 INFO - Detecting whether we're running mozinstall >=1.0... 22:04:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:04:39 INFO - Reading from file tmpfile_stdout 22:04:39 INFO - Output received: 22:04:39 INFO - Usage: mozinstall [options] installer 22:04:39 INFO - Options: 22:04:39 INFO - -h, --help show this help message and exit 22:04:39 INFO - -d DEST, --destination=DEST 22:04:39 INFO - Directory to install application into. [default: 22:04:39 INFO - "/builds/slave/test"] 22:04:39 INFO - --app=APP Application being installed. [default: firefox] 22:04:39 INFO - mkdir: /builds/slave/test/build/application 22:04:39 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'] 22:04:39 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 22:05:14 INFO - Reading from file tmpfile_stdout 22:05:14 INFO - Output received: 22:05:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:05:14 INFO - Running post-action listener: _resource_record_post_action 22:05:14 INFO - ##### 22:05:14 INFO - ##### Running run-tests step. 22:05:14 INFO - ##### 22:05:14 INFO - Running pre-action listener: _resource_record_pre_action 22:05:14 INFO - Running main action method: run_tests 22:05:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:05:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:05:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:05:14 INFO - 2016-04-05 22:05:14.332 screenresolution[1641:7507] starting screenresolution argv=screenresolution get 22:05:14 INFO - 2016-04-05 22:05:14.335 screenresolution[1641:7507] Display 0: 1600x1200x32@60 22:05:14 INFO - 2016-04-05 22:05:14.341 screenresolution[1642:7509] starting screenresolution argv=screenresolution list 22:05:14 INFO - Available Modes on Display 0 22:05:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:05:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:05:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:05:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:05:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:05:14 INFO - Intel Iris: 22:05:14 INFO - Chipset Model: Intel Iris 22:05:14 INFO - Type: GPU 22:05:14 INFO - Bus: Built-In 22:05:14 INFO - VRAM (Dynamic, Max): 1536 MB 22:05:14 INFO - Vendor: Intel (0x8086) 22:05:14 INFO - Device ID: 0x0a2e 22:05:14 INFO - Revision ID: 0x0009 22:05:14 INFO - Displays: 22:05:14 INFO - Display: 22:05:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:05:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:05:14 INFO - Display Serial Number: 1600x1200 60 22:05:14 INFO - Main Display: Yes 22:05:14 INFO - Mirror: Off 22:05:14 INFO - Online: Yes 22:05:14 INFO - Rotation: Supported 22:05:14 INFO - Return code: 0 22:05:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:05:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:05:14 INFO - Python 2.7.3 22:05:14 INFO - Return code: 0 22:05:14 INFO - grabbing minidump binary from tooltool 22:05:14 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')]} 22:05:14 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 0x10ee6ce00>, '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 0x10ec95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee67b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:05:14 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 22:05:14 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 22:05:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:05:14 INFO - Return code: 0 22:05:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:05:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:05:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:05:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:05:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:05:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:05:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:05:15 INFO - Return code: 0 22:05:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--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 22:05:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0163 --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 22:05:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRvsnaa25I/Render', 22:05:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:05:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:05:15 INFO - 'HOME': '/Users/cltbld', 22:05:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:05:15 INFO - 'LOGNAME': 'cltbld', 22:05:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:05:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:15 INFO - 'MOZ_NO_REMOTE': '1', 22:05:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:05:15 INFO - 'NO_EM_RESTART': '1', 22:05:15 INFO - 'PAGER': '/bin/cat', 22:05:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:15 INFO - 'PWD': '/builds/slave/test', 22:05:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:05:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:05:15 INFO - 'SHELL': '/bin/bash', 22:05:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOHWQjpfId/Listeners', 22:05:15 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 22:05:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:05:15 INFO - 'USER': 'cltbld', 22:05:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:05:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:15 INFO - 'XPC_FLAGS': '0x0', 22:05:15 INFO - 'XPC_SERVICE_NAME': '0', 22:05:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:05:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--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 22:05:16 INFO - mozversion application_buildid: 20160405205220 22:05:16 INFO - mozversion application_changeset: e003ad2de364adc21bd7ed89715bc6f397ba9739 22:05:16 INFO - mozversion application_display_name: Nightly 22:05:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:05:16 INFO - mozversion application_name: Firefox 22:05:16 INFO - mozversion application_remotingname: firefox 22:05:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:05:16 INFO - mozversion application_vendor: Mozilla 22:05:16 INFO - mozversion application_version: 48.0a1 22:05:16 INFO - mozversion platform_buildid: 20160405205220 22:05:16 INFO - mozversion platform_changeset: e003ad2de364adc21bd7ed89715bc6f397ba9739 22:05:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:05:16 INFO - mozversion platform_version: 48.0a1 22:05:16 INFO - using testdate: 1459919116 22:05:16 INFO - actual date: 1459919116 22:05:16 INFO - starting webserver on 'localhost:49279' 22:05:16 INFO - SUITE-START | Running 2 tests 22:05:16 INFO - TEST-START | dromaeo_css 22:05:16 INFO - operating with platform_type : mac_ 22:05:16 INFO - Initialising browser for dromaeo_css test... 22:05:16 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpgOEoR6/profile http://localhost:49279/getInfo.html) 22:05:18 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 22:05:18 INFO - PROCESS | 1660 | colorDepth:24 22:05:18 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 22:05:18 INFO - PROCESS | 1660 | __metrics 22:05:18 INFO - PROCESS | 1660 | 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" 22:05:18 ERROR - PROCESS | 1660 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:05:19 INFO - TEST-INFO | 1660: exit 0 22:05:19 INFO - Browser initialized. 22:05:19 INFO - Running cycle 1/1 for dromaeo_css test... 22:05:19 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpgOEoR6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:05:31 INFO - PROCESS | 1662 | RSS: Main: 235974656 22:05:31 INFO - PROCESS | 1662 | 22:06:22 INFO - PROCESS | 1662 | 1459919182023 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] 22:08:32 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 22:08:33 INFO - PROCESS | 1662 | RSS: Main: 347095040 22:08:33 INFO - PROCESS | 1662 | 22:11:35 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 22:11:36 INFO - PROCESS | 1662 | RSS: Main: 358854656 22:11:36 INFO - PROCESS | 1662 | 22:14:38 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 22:14:39 INFO - PROCESS | 1662 | RSS: Main: 356110336 22:14:39 INFO - PROCESS | 1662 | 22:17:41 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 22:17:41 INFO - PROCESS | 1662 | RSS: Main: 321843200 22:17:41 INFO - PROCESS | 1662 | 22:20:44 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 22:20:45 INFO - PROCESS | 1662 | RSS: Main: 325160960 22:20:45 INFO - PROCESS | 1662 | 22:23:48 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 22:23:48 INFO - PROCESS | 1662 | RSS: Main: 369295360 22:23:48 INFO - PROCESS | 1662 | 22:23:48 INFO - PROCESS | 1662 | __start_tp_report 22:23:48 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 22:23:48 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 22:23:48 INFO - PROCESS | 1662 | |i|pagename|runs| 22:23:48 INFO - PROCESS | 1662 | |0;dojo.html;3392.1180493071797;3452.8087809705657;3476.0440878758322;3491.423915054016;3521.3485505181543;5518.19986102015;5604.691741954196;5607.4112218217115;5613.859653508664;5619.269494965654;5594.9720251398785;5637.9718101409435;5685.1756495308155;5688.288963879515;5716.7141642917895;5052.393712754475;5076.187809950399;5099.464556221599;5109.565686916598;5168.896622067575;4338.913221735564;5201.531862132408;5217.530422261995;5266.657667251636;5267.631265811395;5006.6245031622775;5090.847274581768;5107.412647545542;5164.561012313939;5215.634905556593;4215.367694845767;5007.599392048627;5129.0767661820855;5175;5191.792328306901;5058.873528161788;5071;5077.543021128079;5083.38999320084;5097.7960881564695;5441.863953401196;5521.3926468088475;5531.502164805187;5549.861253468655;5556.611037227396;6051.1225872248715;6091.238595175603;6147.44672979434;6155.984262596666;6174.043023331391;6142.539309551801;6175.042868355412;6208.2239720034995;6228.470580000705;6233.189685340877;5565.499105080481;5700.37295897451;5703.0589952657765;5707.286589176353;5742.856428589277;6225.750969961151;6253.155823963707;6301.338359472281;6311.526635502356;6316.747330106836;5951.880962380815;5997.550183736237;6004.339522652592;6014.48876845473;6034.879302414015;6027.457528822427;6204.472619827366;6205.28639206488;6217.191765070512;6245.5628106033055;5926.585139040312;6060.33336333003;6119.51223155561;6122.581127188521;6145.647957449443;6116.914073580098;6122.367660829195;6136.91186679386;6139.308154112039;6140.3552626974415;4765.4996225395835;4840.733759643183;4845.394325709286;4853.878653033632;4883.413990321184;4317.266064768997;4334.674899382559;4342.174986752507;4387.210302145644;4396.296592545177;5585.916211256835;5624.100143976944;5632.098864181711;5645.040343141676;5653.717314134276;5993.250843644544;6210.130581718563;6229.875402492015;6238.625682459067;6241.937580624226;5579.553635709133;5602.38373778884;5674.602777805597;5703.885922281531;5733.140028995601;5272.340957380327;5273.235380869753;5282.550983166397;5283.471652834686;5289.920651190235;6105.328413874381;6320.241571011416;6320.273168585672;6323.5889667172405;6328.272248691367;5209.817656382009;6105.186826067751;6108.694565271808;6216.564840461305;6226.12834203221;6265.655388953652;6290.308066112632;6297.307296197323;6303.936960630518;6325.9683701583035;5911.940880591311;6092.360302168386;6097.5426842987845;6103.084537319438;6117.449429551361;4929.950700493093;6043.09353596964;6097.524678803442;6118.192813661829;6121.788327166137;6002.909956350571;6038.456538911519;6043.607165534227;6044.969775151096;6054.061620448838;5843.970780146242;5864.32560255576;6022.126791615279;6043.214382130295;6047.606905551125;5803.071508558611;5819.330776960704;5839.445252700986;5856.795012174553;5900.763969441346;5964.850878727893;6000.939990600213;6004.489618382487;6011;6013.699315034319;5620.74706638194;5727.7422515986045;5835.56233282497;5835.9708201458725;5838.416158384128 22:23:48 INFO - PROCESS | 1662 | |1;ext.html;492.4730538323995;580.8731061740224;581.7004242814951;637.1525870592113;639.2488825629887;38177;38643.42034869476;38666.613333866655;38705.41941870874;38717.61282387175;41393.7930310348;41758.79120604401;41916.79041604795;41919;42079.15841683172;9348.439093654368;9468.57391417388;9490.430574165537;9575.664851730191;9583.904160958406;9441.480718560477;9621.855672164924;9625.663101791439;9636.277279204052;9637.325387222898;9651.662191823287;9728.416295022285;9736.951315243414;9740.074692904163;9760.316777825556;9612;9654.758631034245;9725.465099419565;9730.41617502945;9734.805303893952;9531.285153613437;9672.08115229052;9675.564599593035;9679.322447428684;9686.564104615309;39673;39905.40141897874;40164.59835401638;40185.59814401877;40217;3251.869925202989;3306.123877172551;3319.5020746887917;3410.454327307644;3783.4703141560203;26498.80755366013;26559.937602495876;26601.46797064048;26742.930282788664;27055.45889082227;2750.559910414344;2771.0993926973815;2775.5420355641295;2775.6946735859037;2833.631627888382;418202;419794;419820;420033.89983050193;420519;44153.11693766106;45008;61356;61776;62317.37682623116;45321;45519.317210241876;45613.77193114079;45739;45826;15637.921810390875;15774.526764197093;15806.841931580768;15832.68334633301;15834.12912289812;12719.55481558141;12764.489420423079;12766.361681915867;12817.743645127232;12865.614031579067;14430.855691443161;14440.638984025274;14476.34856431463;14520.564383068524;14621.561353159423;5309.442508536548;6261.467775239064;6327.651979141099;6381.553291269659;6389.137466442064;910.6266430763355;970.8883328588727;997.3268044070223;1027.773889744255;1045.592219034577;27069.323266918484;28067.57898631522;28418.573721394194;28847.71152288492;28959.7104028957;905.8369493491235;1099.587654629514;1152.4871432212753;1155.4684844971239;1156.9363684997406;12347.19743216688;12432.564860229848;13682.726345473235;14882.479113230986;15027.774583381259;478099;478581.4283714376;482880;484114;485373.57313213206;56859.14711279334;57296.42703572994;57327.71336143293;57400.13899791506;57477.71261143751;1320.399218355665;1420.7442660321035;1424.181095869879;1458.023124506562;1462.159258426409;27862.58206126869;28466.430671386042;28687.35727527514;28975.85512072426;29316;44433.77783111064;44559.777201113786;44817.103657926;44852;44939.775301124595;335531.64468355005;336056;337242;337436;337606;27823.02619408311;31368.37263254768;32619.83690081629;32641.85753498616;32657.18357041093;39870.80064599775;40517;40650.79674601608;40874.9781255471;41803.7909810449;34616.30767384689;35220;35428.93713188609;35989.46015809713;36211.637883620824;33453.33093338168;34327.82836085804;34496.827515862264;34923.777667781505;35309.940701778985;35481;35697.1075723109;35823.92528224157;36481;37631.247375052895;30856.69143308628;32032.83983580067;32294.83852580722;32336.029919102464;32556.348873022882;23972.88013559921;24078.157264495658;24666.13668521593;24742.752572474044;24861.751382485945 22:23:48 INFO - PROCESS | 1662 | |2;jquery.html;356.31942988891217;356.60416937199705;361.52640041545567;368.7455655597636;372.6943905997082;19352.322668706598;19478.805211947893;20718;20730.68903966438;20760.377188684346;19280.51798705033;19633;20228.190872365125;20448.693269600968;20487.795122048774;5733.082706766918;5821.708914554277;5839.708014599274;5869.530437565006;5872.383399743029;4191.1617676464675;4325.74045557266;5907.113932910076;6186.721597528122;6502.577332473397;6435.742570297182;6440.194975628046;6445.129907462479;6454.225492940854;6466.676666166696;6198.690065496752;6297.937020629804;6381.361863813581;6383.840403989938;6411.967940160316;3699.7040236781263;5304.840854774363;5471.37079235885;5523.28197334348;5529.253550770634;23024;23480.64779028316;23745.287641370785;23951.16170934009;23999.52000959971;2194.484296190394;2276.1805749930013;2278.715160604924;2314.9189778357677;2316.397736588482;14008.649783755385;14294.070885392417;14470.565883023526;14803.555893323217;14959.626009349853;1682.6718789835986;1780.3590707345345;1800.7839059312835;1811.845993090589;1820.9271629134819;82436;85058.57470712607;92442.53778731063;92720;92929;8973.865392019125;10764.677059688222;10868.836967445495;11047.613333533287;11069.557217711363;13416;13477.460901563827;13482.460701572023;13485.730285394236;13514.256715880525;8178.345732341399;8315.501069935823;8345.582720863933;8435.144268260972;8441.240288374076;6744.5616034957575;8369.665213391396;8383.832323353621;8496.235338819535;8497.915020849836;4265.445492086071;4356.128774245164;4369.694121411534;4389.934150987738;4407.140607581491;1575.5430925031612;1690.1464760295971;1778.8399044086095;1787.8390944814769;1791.3461586520825;869.4218344800763;884.4737381258141;916.6791622932054;917.2936838634214;1031.9484025798681;17939.37212197567;18389.26442942294;19073.523161920784;19089.809101909083;19202.711959320623;941.4727752458645;965.5172413793103;968.8352979993418;970.2383628851318;1008.6016023670755;10136.645217417356;10539.42033188182;10561;10568.471576421149;10611.681649550526;473499;483302;485620;573778;592311;67833.66083169552;78966;100871;101567;110335;991.2862738828032;1013.9594416223416;1028.321307936773;1031.4945676618404;1035.063267742694;17348.566285842953;17435.50388446743;17443.738343924597;17774.20016099253;18046.5488362792;48976.755116224194;50098.49901501084;50582.49417505925;50801.49198507968;50983.745081274355;64442.677786610766;66683.57451887138;70252;71083.28916710766;71552.9267061005;7463.179050304354;7679.884801727867;7754.495957762728;7820.3743700504965;7838.372930165687;8888.777780555538;11394.658160255205;11920.880791191978;12293.569725059937;12377.443015064524;10459.320144190908;10459.64024676787;10719.785604288027;10843.783124337311;10909.672709818718;8876.778080548038;9152.63389464414;10200;10278.794424111626;10330.276880618285;10489.213309002009;10553;10557.841632375674;10726.946365268124;10952.890471095187;7534.698612055676;7624.656890439833;7723.884141737766;7746.225377462209;7912.406569507195;8599.527026013378;10325.896741032793;10410.375377477376;10582.894171058191;10630.681079567625 22:23:48 INFO - PROCESS | 1662 | |3;mootools.html;1437.209534755884;1569.2075501871552;1604.7913771209742;1863.310575087218;1998.8101130392608;7828.60856957152;8457.746267611974;8624.180702833228;8632.870506942385;8660.480371177719;8397.412181147321;8568.614412351444;8585.14148585141;8597.785055373619;8599.871001934976;2417.117752020513;2451.48518811049;2451.656768052474;2452.16626347042;2457.680501534807;2422.9030838766516;2431.0640403444622;2480.7519248075137;2484.7266800651914;2495.962560561584;2437.8293519453646;2454.3864033991504;2483.615039668854;2487.253823852846;2488.2410864686262;2444.046821739523;2455.3002394317623;2465.827392082546;2480.7147178074574;2480.8263421560496;2427.5023620157826;2456.1894574790276;2463.224084413404;2466.260121963404;2486.676732024825;8690.913090869073;8716.651333946635;8733.301335893113;8737.519436430994;8749.912500874974;4614.561616646413;5265.131253343194;5453.127499600045;5465.207544905967;5470.370907345667;3485.4771784232566;3599.1541987632886;3627.818609069536;3649.8540058397634;3665.083729067733;1036.461040259061;1047.9109275711573;1048.501961568249;1055.4669891704716;1060.671191930504;11700;11710.355930423822;11730.765384692259;11737.295762254293;11739.941300293529;4832.081904438216;4832.903341933212;4858.5384388483035;4905.386826646669;4916.483769204254;9943.204543636492;9957.103860652576;9968.252381071448;9971.950140249251;9975.800483990424;5441.156620723794;5449.836504904859;5450.100733379028;5450.400455949843;5460.645058071292;4432.202203603318;4525.117602067631;4526.59260666535;4531.796069176895;4950.950490495049;3677.338079145726;3822.9426558601645;3852.8844134676006;3866.7679939203176;3874.1089549403796;1203.5136606291223;1219.7194645231468;1279.0854539004656;1281.1224311346757;1291.8643542428097;1320.933953302331;1324.245180247269;1355.1327150623608;1362.3596909452542;1363.4205462678322;7882.014748156481;7928.524288542706;8035.316998055114;8050.838983220303;8084.312833409226;1172.3141961952354;1186.6262127429832;1193.1409385242785;1201.375284851872;1218.981715274254;6049.818505444844;6156.26124865019;6173.135760993465;6175.2589689237575;6180.196574445384;9604.807903842024;10019.148372388283;10044.347117437343;10169.847452288222;10185.796284074426;9758.853617195748;9998.900010999796;10048.748781280381;10062.446565438824;10088.546015429323;8164.142765009708;8283.710070147516;8339.45793523419;8347.874781878276;8361.874571881426;7883.5664038478435;7901.762947111596;8074.1522140176785;8085.9595702021115;8169.428140030379;8885.644574217218;9251.907480925105;9533.713988580077;9624.951875240578;9635.662751803653;9231.676891308773;9478.194353480032;9504.619815207314;9556.426614403159;9710.70867873965;7366.852662946604;7394.44716609518;7480.925190748023;7512.661930213263;7513.849723005618;8003.879941800761;8059.194080591894;8098.75703728889;8121.67513299485;8138.4303098784885;7347.55914645123;7366.558006519626;7394.741184058532;7506.774796756106;7515.586642734702;6157.291911430064;7197.856042879218;7204.919262110725;7294.890576641461;7362.22696616869;7320.707171713285;7630.1606823248285;7634.351080158027;7641.808954776175;7732.690692372467;6896.655167241718;6939.861202775815;6955.826104347229;6965.373116419547;6968.651567421507;6981.162260528769;6998.055262539492;7016.228214896255;7017.754378596725;7072.328128827753 22:23:48 INFO - PROCESS | 1662 | |4;prototype.html;321.1489552685383;325.50523204728813;330.8593847614764;332.5460746081599;336.23338787564364;6460.353964603543;6542.96728516358;6548.869022619545;6581.5721978071515;6585.83535411615;6445.162128923245;6528.183977002875;6528.510361722878;6530.314316996706;6536.934630653692;4604.769761511911;4695.389599352079;4720.12677654635;4819.590334821527;4857.659963802526;4812.807487700487;4822.204336284526;4837.7822997965;4845.927311090337;4846.200376937801;4799.664023518355;4801.159797035522;4801.61587073035;4814.205656066745;4824.0834241494;4567.497575266718;4700.529947005272;4714.080754252922;4726.598239149642;4822.879428014293;4004.7196696231276;4068.6338229559483;4097.955021469536;4102.015516276102;4102.815373308208;6155.353687862755;6188.071789231606;6230.906536401958;6233.470155036827;6239.937600624026;5598.692071936042;5599.524040456566;5608.065217499956;5608.635438696512;5610.607257491977;6842.281560436182;6856.554323968976;6864.279250678706;6867.828304292432;6877.4841886858685;3805.429185622151;4461.24158892989;4619.053094115732;4625.8149674013;4637.072585482883;6419.3259707730485;6519.315471875432;7101.857962840766;7156.821079473003;7201.711931522733;3872.6320999505;4704.317873908264;4728.763561821896;4729.527047295312;4729.6689231754135;4784.378030855966;4809.735464549413;4813.927791083137;4822;4822.807087716522;5598.10430331145;5602.495775380154;5602.6918519481005;5602.943970560243;5611.6071874969175;6613.603183808987;6862;6866.416354609814;6883.208431030395;6894.965525172342;1652.2647421897382;1656.5858535366158;1670.7076261654404;1672.5567724553002;1674.3637417781165;1082.3127314155568;1085.978280434387;1106.3140852671233;1110.1895616200059;1111.8721347045032;6301.180846489927;6480.870382592416;6482.513811464159;6515.804525864137;6517.478601711851;7070.611116388648;7082.433405327562;7090.751823686146;7104.147502299757;7121.252268511732;6303.7793677222;6436.066770318372;6493.805185844432;6547.758859364645;6567.540272180997;3766.2844059628583;3802.7718336899875;3805.8667946621736;3820.522434695663;3823.1971286030243;6191.783287585003;7241.348278654947;7517.060367454068;7522.511036782701;7563.205863384375;5962.22491076166;7427.145878223965;7432.368248698813;7435.888461673079;7441.627918604048;7463.253674632493;7506.774796756106;7518;7536.359409450258;7544.886826697604;5462.945370546403;7159.03353047332;7162.677679504539;7168.426525877813;7179.317964793337;6752.155980502437;7040.718371265092;7040.964795175992;7043.647817609201;7068.752593659197;7504.662290196845;7509.887351689838;7530.623468826647;7530.774076777706;7539.773806785805;4118.649914757159;4702.670813043054;4739.123262196505;4744.644151688568;4751.239801631722;7153.785386438415;7156.713731450892;7174;7179.569225846466;7184.389326907062;5998.820035398945;6281.59169653971;6913.619750913748;6931.2375638678695;6942.305769423017;5631.2960879890015;6908.585484870924;6921.2732663069655;6924.515283930076;6930.930690693029;6703.966480167763;6746.4265537429865;6769.4922880785125;6777.220619628806;6781.728730850711;5713.828585142286;6848.931510685029;6932.826679333057;6932.930670693228;6958.721651133898;6497.480201583957;6759;6764.526483146133;6774.898376524257;6809.114815074008 22:23:48 INFO - PROCESS | 1662 | |5;yui.html;666.5201055240227;701.424831638057;747.2639450141613;758.8861670749387;784.6273020315349;14823.184724840143;15148.848511514881;15222.238888055608;15245.856560757931;15262.160581168031;12515.186512876679;13988.65028374291;14053.437862485514;14063;14092.43630254791;911.5077857956695;940.9482478463682;944.6221511395462;945.6217512994823;945.8486642137259;923.3075193604797;930.0188301342081;934.7569631895722;936.3819878879941;937.8968313485511;780.574586850168;814.6741303478597;974.1573538888881;996.1084829077971;999.2505620784411;986.0780170540568;986.2061040862103;988.9703308900672;989.678354534779;989.7525618595315;733.9302766237199;734.2437289591729;734.7097896330973;735.6395366270542;736.4439847914844;14759.557213283619;14855.182964936925;14864.851351486455;14870.553883383516;14874.851251487455;12396.56612018584;12633.557825476157;12750.10749247553;12851.293178875158;12943.935280323632;9810.75473113178;10021;10284.845727314096;10358.948205258925;10568.682939511827;3341.465365541526;3343.8996830095134;3348.41402754517;3352.5661095622145;3392.77946933451;81099.59450202712;81745.18254817436;81852;82592;82908.3418331636;9494.572744226527;9507.286953478517;9575.664851730156;9725.6596019139;9823.950880245553;20644;20939.68590471144;22314.776852231593;22367;22387;7459.440541959375;7470.252974702595;7520.586367749826;7719.845603087907;7845.921540784633;3895.649391554717;3974;4006.358982562834;4038.030872590557;4047.5952404759287;3545.2732189901008;3598.956302672248;3604.693601043888;3607.206414588786;3608.1881576645046;629.0752593687272;629.4429429954523;641.5156556799586;661.7419206509466;664.6244871647503;529.993013274781;540.1096163428002;592.2448877680991;600.639616230267;609.7926704920349;7776.222377762178;7902.4863383879865;7976.202379761978;8172.836543269102;8340.04089529712;512.9487051294915;516.790709739212;539.641138642806;566.5189293584634;592.943670351316;3774.584795672474;3776.169242766587;3830.2148059647707;3834.501514803058;4025.6376926076796;84993.57503212444;85100;85298;86486;87318.56340718256;61043.08435373473;75191;75648.62175689197;76228.61885690536;76778.61610691911;64016.67991660012;64712.02931956024;65120;65193;65703.67148164324;7709.190534993745;7718.382529397747;7806.960965195365;7916.683332666629;7924.9207507926485;46888.765556172;47873.04253914832;48418.5158148414;48778.75610622066;49401.75299123481;60505;64004.35995639984;65622.34377656163;65711;66464.67070658656;9782.119609235204;9957.402555846673;9973.45146016947;10068.496575171359;10218.897811021794;8560.160534053763;8658.826823463369;10805.351678899291;10975.28660637056;11652.650420487398;11029.944850275697;11185.776284474428;11365.48855301497;11421.543138274375;11545.134114941246;11142.108631309638;11150.776984460428;11168.888311116785;11517.424128793695;11563.421828908353;10812.189085818438;10905.563777448813;11131.499082541142;11291.548338066385;11307.830382544433;9318.18181818171;9351.672691455766;9404.828189627657;9735.659251926148;9926.354786938826;9246.899928915525;9632.13310802003;9646.42121472714;9659.32384733062;9674 22:23:48 INFO - PROCESS | 1662 | __end_tp_report 22:23:48 INFO - PROCESS | 1662 | __start_cc_report 22:23:48 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1081 22:23:48 INFO - PROCESS | 1662 | __end_cc_report 22:23:48 INFO - PROCESS | 1662 | __startTimestamp1459920228288__endTimestamp 22:23:48 INFO - PROCESS | 1662 | 22:23:48 INFO - PROCESS | 1662 | ------- Summary: start ------- 22:23:48 INFO - PROCESS | 1662 | Number of tests: 6 22:23:48 INFO - PROCESS | 1662 | 22:23:48 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5643.98 Median:5835.97 stddev:637.20 (10.9%) stddev-sans-first:614.18 22:23:48 INFO - PROCESS | 1662 | Values: 3392.1 3452.8 3476.0 3491.4 3521.3 5518.2 5604.7 5607.4 5613.9 5619.3 5595.0 5638.0 5685.2 5688.3 5716.7 5052.4 5076.2 5099.5 5109.6 5168.9 4338.9 5201.5 5217.5 5266.7 5267.6 5006.6 5090.8 5107.4 5164.6 5215.6 4215.4 5007.6 5129.1 5175.0 5191.8 5058.9 5071.0 5077.5 5083.4 5097.8 5441.9 5521.4 5531.5 5549.9 5556.6 6051.1 6091.2 6147.4 6156.0 6174.0 6142.5 6175.0 6208.2 6228.5 6233.2 5565.5 5700.4 5703.1 5707.3 5742.9 6225.8 6253.2 6301.3 6311.5 6316.7 5951.9 5997.6 6004.3 6014.5 6034.9 6027.5 6204.5 6205.3 6217.2 6245.6 5926.6 6060.3 6119.5 6122.6 6145.6 6116.9 6122.4 6136.9 6139.3 6140.4 4765.5 4840.7 4845.4 4853.9 4883.4 4317.3 4334.7 4342.2 4387.2 4396.3 5585.9 5624.1 5632.1 5645.0 5653.7 5993.3 6210.1 6229.9 6238.6 6241.9 5579.6 5602.4 5674.6 5703.9 5733.1 5272.3 5273.2 5282.6 5283.5 5289.9 6105.3 6320.2 6320.3 6323.6 6328.3 5209.8 6105.2 6108.7 6216.6 6226.1 6265.7 6290.3 6297.3 6303.9 6326.0 5911.9 6092.4 6097.5 6103.1 6117.4 4930.0 6043.1 6097.5 6118.2 6121.8 6002.9 6038.5 6043.6 6045.0 6054.1 5844.0 5864.3 6022.1 6043.2 6047.6 5803.1 5819.3 5839.4 5856.8 5900.8 5964.9 6000.9 6004.5 6011.0 6013.7 5620.7 5727.7 5835.6 5836.0 5838.4 22:23:48 INFO - PROCESS | 1662 | 22:23:48 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:55583.18 Median:20980.24 stddev:110543.14 (526.9%) stddev-sans-first:110775.86 22:23:48 INFO - PROCESS | 1662 | Values: 492.5 580.9 581.7 637.2 639.2 38177.0 38643.4 38666.6 38705.4 38717.6 41393.8 41758.8 41916.8 41919.0 42079.2 9348.4 9468.6 9490.4 9575.7 9583.9 9441.5 9621.9 9625.7 9636.3 9637.3 9651.7 9728.4 9737.0 9740.1 9760.3 9612.0 9654.8 9725.5 9730.4 9734.8 9531.3 9672.1 9675.6 9679.3 9686.6 39673.0 39905.4 40164.6 40185.6 40217.0 3251.9 3306.1 3319.5 3410.5 3783.5 26498.8 26559.9 26601.5 26742.9 27055.5 2750.6 2771.1 2775.5 2775.7 2833.6 418202.0 419794.0 419820.0 420033.9 420519.0 44153.1 45008.0 61356.0 61776.0 62317.4 45321.0 45519.3 45613.8 45739.0 45826.0 15637.9 15774.5 15806.8 15832.7 15834.1 12719.6 12764.5 12766.4 12817.7 12865.6 14430.9 14440.6 14476.3 14520.6 14621.6 5309.4 6261.5 6327.7 6381.6 6389.1 910.6 970.9 997.3 1027.8 1045.6 27069.3 28067.6 28418.6 28847.7 28959.7 905.8 1099.6 1152.5 1155.5 1156.9 12347.2 12432.6 13682.7 14882.5 15027.8 478099.0 478581.4 482880.0 484114.0 485373.6 56859.1 57296.4 57327.7 57400.1 57477.7 1320.4 1420.7 1424.2 1458.0 1462.2 27862.6 28466.4 28687.4 28975.9 29316.0 44433.8 44559.8 44817.1 44852.0 44939.8 335531.6 336056.0 337242.0 337436.0 337606.0 27823.0 31368.4 32619.8 32641.9 32657.2 39870.8 40517.0 40650.8 40875.0 41803.8 34616.3 35220.0 35428.9 35989.5 36211.6 33453.3 34327.8 34496.8 34923.8 35309.9 35481.0 35697.1 35823.9 36481.0 37631.2 30856.7 32032.8 32294.8 32336.0 32556.3 23972.9 24078.2 24666.1 24742.8 24861.8 22:23:48 INFO - PROCESS | 1662 | 22:23:48 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:30501.43 Median:359.07 stddev:86656.60 (24133.9%) stddev-sans-first:86870.13 22:23:48 INFO - PROCESS | 1662 | Values: 356.3 356.6 361.5 368.7 372.7 19352.3 19478.8 20718.0 20730.7 20760.4 19280.5 19633.0 20228.2 20448.7 20487.8 5733.1 5821.7 5839.7 5869.5 5872.4 4191.2 4325.7 5907.1 6186.7 6502.6 6435.7 6440.2 6445.1 6454.2 6466.7 6198.7 6297.9 6381.4 6383.8 6412.0 3699.7 5304.8 5471.4 5523.3 5529.3 23024.0 23480.6 23745.3 23951.2 23999.5 2194.5 2276.2 2278.7 2314.9 2316.4 14008.6 14294.1 14470.6 14803.6 14959.6 1682.7 1780.4 1800.8 1811.8 1820.9 82436.0 85058.6 92442.5 92720.0 92929.0 8973.9 10764.7 10868.8 11047.6 11069.6 13416.0 13477.5 13482.5 13485.7 13514.3 8178.3 8315.5 8345.6 8435.1 8441.2 6744.6 8369.7 8383.8 8496.2 8497.9 4265.4 4356.1 4369.7 4389.9 4407.1 1575.5 1690.1 1778.8 1787.8 1791.3 869.4 884.5 916.7 917.3 1031.9 17939.4 18389.3 19073.5 19089.8 19202.7 941.5 965.5 968.8 970.2 1008.6 10136.6 10539.4 10561.0 10568.5 10611.7 473499.0 483302.0 485620.0 573778.0 592311.0 67833.7 78966.0 100871.0 101567.0 110335.0 991.3 1014.0 1028.3 1031.5 1035.1 17348.6 17435.5 17443.7 17774.2 18046.5 48976.8 50098.5 50582.5 50801.5 50983.7 64442.7 66683.6 70252.0 71083.3 71552.9 7463.2 7679.9 7754.5 7820.4 7838.4 8888.8 11394.7 11920.9 12293.6 12377.4 10459.3 10459.6 10719.8 10843.8 10909.7 8876.8 9152.6 10200.0 10278.8 10330.3 10489.2 10553.0 10557.8 10726.9 10952.9 7534.7 7624.7 7723.9 7746.2 7912.4 8599.5 10325.9 10410.4 10582.9 10630.7 22:23:48 INFO - PROCESS | 1662 | 22:23:48 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5965.13 Median:5467.79 stddev:3080.30 (56.3%) stddev-sans-first:3070.13 22:23:48 INFO - PROCESS | 1662 | Values: 1437.2 1569.2 1604.8 1863.3 1998.8 7828.6 8457.7 8624.2 8632.9 8660.5 8397.4 8568.6 8585.1 8597.8 8599.9 2417.1 2451.5 2451.7 2452.2 2457.7 2422.9 2431.1 2480.8 2484.7 2496.0 2437.8 2454.4 2483.6 2487.3 2488.2 2444.0 2455.3 2465.8 2480.7 2480.8 2427.5 2456.2 2463.2 2466.3 2486.7 8690.9 8716.7 8733.3 8737.5 8749.9 4614.6 5265.1 5453.1 5465.2 5470.4 3485.5 3599.2 3627.8 3649.9 3665.1 1036.5 1047.9 1048.5 1055.5 1060.7 11700.0 11710.4 11730.8 11737.3 11739.9 4832.1 4832.9 4858.5 4905.4 4916.5 9943.2 9957.1 9968.3 9972.0 9975.8 5441.2 5449.8 5450.1 5450.4 5460.6 4432.2 4525.1 4526.6 4531.8 4951.0 3677.3 3822.9 3852.9 3866.8 3874.1 1203.5 1219.7 1279.1 1281.1 1291.9 1320.9 1324.2 1355.1 1362.4 1363.4 7882.0 7928.5 8035.3 8050.8 8084.3 1172.3 1186.6 1193.1 1201.4 1219.0 6049.8 6156.3 6173.1 6175.3 6180.2 9604.8 10019.1 10044.3 10169.8 10185.8 9758.9 9998.9 10048.7 10062.4 10088.5 8164.1 8283.7 8339.5 8347.9 8361.9 7883.6 7901.8 8074.2 8086.0 8169.4 8885.6 9251.9 9533.7 9625.0 9635.7 9231.7 9478.2 9504.6 9556.4 9710.7 7366.9 7394.4 7480.9 7512.7 7513.8 8003.9 8059.2 8098.8 8121.7 8138.4 7347.6 7366.6 7394.7 7506.8 7515.6 6157.3 7197.9 7204.9 7294.9 7362.2 7320.7 7630.2 7634.4 7641.8 7732.7 6896.7 6939.9 6955.8 6965.4 6968.7 6981.2 6998.1 7016.2 7017.8 7072.3 22:23:48 INFO - PROCESS | 1662 | 22:23:48 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:5648.04 Median:6440.61 stddev:1774.24 (27.5%) stddev-sans-first:1733.58 22:23:48 INFO - PROCESS | 1662 | Values: 321.1 325.5 330.9 332.5 336.2 6460.4 6543.0 6548.9 6581.6 6585.8 6445.2 6528.2 6528.5 6530.3 6536.9 4604.8 4695.4 4720.1 4819.6 4857.7 4812.8 4822.2 4837.8 4845.9 4846.2 4799.7 4801.2 4801.6 4814.2 4824.1 4567.5 4700.5 4714.1 4726.6 4822.9 4004.7 4068.6 4098.0 4102.0 4102.8 6155.4 6188.1 6230.9 6233.5 6239.9 5598.7 5599.5 5608.1 5608.6 5610.6 6842.3 6856.6 6864.3 6867.8 6877.5 3805.4 4461.2 4619.1 4625.8 4637.1 6419.3 6519.3 7101.9 7156.8 7201.7 3872.6 4704.3 4728.8 4729.5 4729.7 4784.4 4809.7 4813.9 4822.0 4822.8 5598.1 5602.5 5602.7 5602.9 5611.6 6613.6 6862.0 6866.4 6883.2 6895.0 1652.3 1656.6 1670.7 1672.6 1674.4 1082.3 1086.0 1106.3 1110.2 1111.9 6301.2 6480.9 6482.5 6515.8 6517.5 7070.6 7082.4 7090.8 7104.1 7121.3 6303.8 6436.1 6493.8 6547.8 6567.5 3766.3 3802.8 3805.9 3820.5 3823.2 6191.8 7241.3 7517.1 7522.5 7563.2 5962.2 7427.1 7432.4 7435.9 7441.6 7463.3 7506.8 7518.0 7536.4 7544.9 5462.9 7159.0 7162.7 7168.4 7179.3 6752.2 7040.7 7041.0 7043.6 7068.8 7504.7 7509.9 7530.6 7530.8 7539.8 4118.6 4702.7 4739.1 4744.6 4751.2 7153.8 7156.7 7174.0 7179.6 7184.4 5998.8 6281.6 6913.6 6931.2 6942.3 5631.3 6908.6 6921.3 6924.5 6930.9 6704.0 6746.4 6769.5 6777.2 6781.7 5713.8 6848.9 6932.8 6932.9 6958.7 6497.5 6759.0 6764.5 6774.9 6809.1 22:23:48 INFO - PROCESS | 1662 | 22:23:48 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:17631.93 Median:32676.77 stddev:24483.40 (74.9%) stddev-sans-first:24518.95 22:23:48 INFO - PROCESS | 1662 | Values: 666.5 701.4 747.3 758.9 784.6 14823.2 15148.8 15222.2 15245.9 15262.2 12515.2 13988.7 14053.4 14063.0 14092.4 911.5 940.9 944.6 945.6 945.8 923.3 930.0 934.8 936.4 937.9 780.6 814.7 974.2 996.1 999.3 986.1 986.2 989.0 989.7 989.8 733.9 734.2 734.7 735.6 736.4 14759.6 14855.2 14864.9 14870.6 14874.9 12396.6 12633.6 12750.1 12851.3 12943.9 9810.8 10021.0 10284.8 10358.9 10568.7 3341.5 3343.9 3348.4 3352.6 3392.8 81099.6 81745.2 81852.0 82592.0 82908.3 9494.6 9507.3 9575.7 9725.7 9824.0 20644.0 20939.7 22314.8 22367.0 22387.0 7459.4 7470.3 7520.6 7719.8 7845.9 3895.6 3974.0 4006.4 4038.0 4047.6 3545.3 3599.0 3604.7 3607.2 3608.2 629.1 629.4 641.5 661.7 664.6 530.0 540.1 592.2 600.6 609.8 7776.2 7902.5 7976.2 8172.8 8340.0 512.9 516.8 539.6 566.5 592.9 3774.6 3776.2 3830.2 3834.5 4025.6 84993.6 85100.0 85298.0 86486.0 87318.6 61043.1 75191.0 75648.6 76228.6 76778.6 64016.7 64712.0 65120.0 65193.0 65703.7 7709.2 7718.4 7807.0 7916.7 7924.9 46888.8 47873.0 48418.5 48778.8 49401.8 60505.0 64004.4 65622.3 65711.0 66464.7 9782.1 9957.4 9973.5 10068.5 10218.9 8560.2 8658.8 10805.4 10975.3 11652.7 11029.9 11185.8 11365.5 11421.5 11545.1 11142.1 11150.8 11168.9 11517.4 11563.4 10812.2 10905.6 11131.5 11291.5 11307.8 9318.2 9351.7 9404.8 9735.7 9926.4 9246.9 9632.1 9646.4 9659.3 9674.0 22:23:48 INFO - PROCESS | 1662 | -------- Summary: end -------- 22:23:48 INFO - PROCESS | 1662 | 22:23:48 INFO - TEST-INFO | 1662: exit 0 22:23:48 INFO - TEST-OK | dromaeo_css | took 1112724ms 22:23:48 INFO - TEST-START | kraken 22:23:48 INFO - operating with platform_type : mac_ 22:23:48 INFO - Initialising browser for kraken test... 22:23:48 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmp01Vj3f/profile http://localhost:49279/getInfo.html) 22:23:51 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 22:23:51 INFO - PROCESS | 1671 | colorDepth:24 22:23:51 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 22:23:51 INFO - PROCESS | 1671 | __metrics 22:23:51 INFO - PROCESS | 1671 | 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" 22:23:51 ERROR - PROCESS | 1671 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:23:51 INFO - TEST-INFO | 1671: exit 0 22:23:51 INFO - Browser initialized. 22:23:51 INFO - Running cycle 1/1 for kraken test... 22:23:51 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmp01Vj3f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:24:03 INFO - PROCESS | 1673 | RSS: Main: 235913216 22:24:03 INFO - PROCESS | 1673 | 22:24:06 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 22:24:07 INFO - PROCESS | 1673 | RSS: Main: 281763840 22:24:07 INFO - PROCESS | 1673 | 22:24:09 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 22:24:10 INFO - PROCESS | 1673 | RSS: Main: 292188160 22:24:10 INFO - PROCESS | 1673 | 22:24:13 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 22:24:14 INFO - PROCESS | 1673 | RSS: Main: 278790144 22:24:14 INFO - PROCESS | 1673 | 22:24:16 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 22:24:16 INFO - PROCESS | 1673 | RSS: Main: 281563136 22:24:16 INFO - PROCESS | 1673 | 22:24:18 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:24:19 INFO - PROCESS | 1673 | RSS: Main: 282791936 22:24:19 INFO - PROCESS | 1673 | 22:24:22 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 22:24:22 INFO - PROCESS | 1673 | RSS: Main: 282918912 22:24:22 INFO - PROCESS | 1673 | 22:24:25 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 22:24:26 INFO - PROCESS | 1673 | RSS: Main: 282902528 22:24:26 INFO - PROCESS | 1673 | 22:24:28 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 22:24:29 INFO - PROCESS | 1673 | RSS: Main: 283254784 22:24:29 INFO - PROCESS | 1673 | 22:24:31 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:24:31 INFO - PROCESS | 1673 | RSS: Main: 315867136 22:24:31 INFO - PROCESS | 1673 | 22:24:33 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:24:34 INFO - PROCESS | 1673 | RSS: Main: 315494400 22:24:34 INFO - PROCESS | 1673 | 22:24:36 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:24:36 INFO - PROCESS | 1673 | RSS: Main: 322428928 22:24:36 INFO - PROCESS | 1673 | 22:24:39 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:24:40 INFO - PROCESS | 1673 | RSS: Main: 323960832 22:24:40 INFO - PROCESS | 1673 | 22:24:42 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:24:43 INFO - PROCESS | 1673 | RSS: Main: 323633152 22:24:43 INFO - PROCESS | 1673 | 22:24:44 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 22:24:45 INFO - PROCESS | 1673 | RSS: Main: 387780608 22:24:45 INFO - PROCESS | 1673 | 22:24:45 INFO - PROCESS | 1673 | __start_tp_report 22:24:45 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 22:24:45 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 22:24:45 INFO - PROCESS | 1673 | |i|pagename|runs| 22:24:45 INFO - PROCESS | 1673 | |0;ai-astar;111;107;110;112;108;112;115;111;112;112 22:24:45 INFO - PROCESS | 1673 | |1;audio-beat-detection;157;126;144;159;140;173;173;117;192;105 22:24:45 INFO - PROCESS | 1673 | |2;audio-dft;189;185;183;185;187;186;183;179;181;180 22:24:45 INFO - PROCESS | 1673 | |3;audio-fft;76;72;84;79;56;58;59;77;79;56 22:24:45 INFO - PROCESS | 1673 | |4;audio-oscillator;94;97;126;78;77;79;111;79;78;111 22:24:45 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;88;85;88;84;87;84;89;84;88;87 22:24:45 INFO - PROCESS | 1673 | |6;imaging-darkroom;133;148;93;96;92;93;93;93;93;92 22:24:45 INFO - PROCESS | 1673 | |7;imaging-desaturate;86;84;85;85;85;86;85;87;86;84 22:24:45 INFO - PROCESS | 1673 | |8;json-parse-financial;57;56;54;55;55;56;57;66;55;52 22:24:45 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;63;69;67;72;69;66;66;65;67;67 22:24:45 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;84;84;83;83;84;81;84;83;84;88 22:24:45 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;121;114;133;123;132;123;133;120;127;133 22:24:45 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;141;128;141;140;137;129;141;140;137;136 22:24:45 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;68;68;69;66;67;66;67;67;68;66 22:24:45 INFO - PROCESS | 1673 | __end_tp_report 22:24:45 INFO - PROCESS | 1673 | __start_cc_report 22:24:45 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1387 22:24:45 INFO - PROCESS | 1673 | __end_cc_report 22:24:45 INFO - PROCESS | 1673 | __startTimestamp1459920285111__endTimestamp 22:24:45 INFO - PROCESS | 1673 | 22:24:45 INFO - PROCESS | 1673 | ------- Summary: start ------- 22:24:45 INFO - PROCESS | 1673 | Number of tests: 14 22:24:45 INFO - PROCESS | 1673 | 22:24:45 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.26 (2.0%) stddev-sans-first:2.40 22:24:45 INFO - PROCESS | 1673 | Values: 111.0 107.0 110.0 112.0 108.0 112.0 115.0 111.0 112.0 112.0 22:24:45 INFO - PROCESS | 1673 | 22:24:45 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:158.00 stddev:27.40 (17.3%) stddev-sans-first:28.90 22:24:45 INFO - PROCESS | 1673 | Values: 157.0 126.0 144.0 159.0 140.0 173.0 173.0 117.0 192.0 105.0 22:24:45 INFO - PROCESS | 1673 | 22:24:45 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:183.80 Median:185.00 stddev:3.19 (1.7%) stddev-sans-first:2.77 22:24:45 INFO - PROCESS | 1673 | Values: 189.0 185.0 183.0 185.0 187.0 186.0 183.0 179.0 181.0 180.0 22:24:45 INFO - PROCESS | 1673 | 22:24:45 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:69.60 Median:76.50 stddev:11.07 (14.5%) stddev-sans-first:11.49 22:24:45 INFO - PROCESS | 1673 | Values: 76.0 72.0 84.0 79.0 56.0 58.0 59.0 77.0 79.0 56.0 22:24:45 INFO - PROCESS | 1673 | 22:24:45 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:78.50 stddev:17.80 (22.7%) stddev-sans-first:18.88 22:24:45 INFO - PROCESS | 1673 | Values: 94.0 97.0 126.0 78.0 77.0 79.0 111.0 79.0 78.0 111.0 22:24:45 INFO - PROCESS | 1673 | 22:24:45 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:87.50 stddev:1.96 (2.2%) stddev-sans-first:1.99 22:24:45 INFO - PROCESS | 1673 | Values: 88.0 85.0 88.0 84.0 87.0 84.0 89.0 84.0 88.0 87.0 22:24:45 INFO - PROCESS | 1673 | 22:24:45 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:102.60 Median:93.00 stddev:20.32 (21.8%) stddev-sans-first:18.33 22:24:45 INFO - PROCESS | 1673 | Values: 133.0 148.0 93.0 96.0 92.0 93.0 93.0 93.0 93.0 92.0 22:24:45 INFO - PROCESS | 1673 | 22:24:45 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.50 stddev:0.95 (1.1%) stddev-sans-first:0.97 22:24:45 INFO - PROCESS | 1673 | Values: 86.0 84.0 85.0 85.0 85.0 86.0 85.0 87.0 86.0 84.0 22:24:45 INFO - PROCESS | 1673 | 22:24:45 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.00 stddev:3.71 (6.6%) stddev-sans-first:3.93 22:24:45 INFO - PROCESS | 1673 | Values: 57.0 56.0 54.0 55.0 55.0 56.0 57.0 66.0 55.0 52.0 22:24:45 INFO - PROCESS | 1673 | 22:24:45 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:2.47 (3.7%) stddev-sans-first:2.13 22:24:45 INFO - PROCESS | 1673 | Values: 63.0 69.0 67.0 72.0 69.0 66.0 66.0 65.0 67.0 67.0 22:24:45 INFO - PROCESS | 1673 | 22:24:45 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:1.75 (2.1%) stddev-sans-first:1.86 22:24:45 INFO - PROCESS | 1673 | Values: 84.0 84.0 83.0 83.0 84.0 81.0 84.0 83.0 84.0 88.0 22:24:45 INFO - PROCESS | 1673 | 22:24:45 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:129.50 stddev:6.72 (5.2%) stddev-sans-first:6.89 22:24:45 INFO - PROCESS | 1673 | Values: 121.0 114.0 133.0 123.0 132.0 123.0 133.0 120.0 127.0 133.0 22:24:45 INFO - PROCESS | 1673 | 22:24:45 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.00 Median:140.00 stddev:4.85 (3.5%) stddev-sans-first:4.93 22:24:45 INFO - PROCESS | 1673 | Values: 141.0 128.0 141.0 140.0 137.0 129.0 141.0 140.0 137.0 136.0 22:24:45 INFO - PROCESS | 1673 | 22:24:45 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.03 (1.5%) stddev-sans-first:1.05 22:24:45 INFO - PROCESS | 1673 | Values: 68.0 68.0 69.0 66.0 67.0 66.0 67.0 67.0 68.0 66.0 22:24:45 INFO - PROCESS | 1673 | -------- Summary: end -------- 22:24:45 INFO - PROCESS | 1673 | 22:24:45 INFO - TEST-INFO | 1673: exit 0 22:24:45 INFO - TEST-OK | kraken | took 56873ms 22:24:45 INFO - SUITE-END | took 1169s 22:24:45 INFO - Completed test suite (00:19:29) 22:24:45 INFO - javascript benchmark 22:24:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3392.1180493071797, 3452.8087809705657, 3476.0440878758322, 3491.423915054016, 3521.3485505181543, 5518.19986102015, 5604.691741954196, 5607.4112218217115, 5613.859653508664, 5619.269494965654, 5594.9720251398785, 5637.9718101409435, 5685.1756495308155, 5688.288963879515, 5716.7141642917895, 5052.393712754475, 5076.187809950399, 5099.464556221599, 5109.565686916598, 5168.896622067575, 4338.913221735564, 5201.531862132408, 5217.530422261995, 5266.657667251636, 5267.631265811395, 5006.6245031622775, 5090.847274581768, 5107.412647545542, 5164.561012313939, 5215.634905556593, 4215.367694845767, 5007.599392048627, 5129.0767661820855, 5175.0, 5191.792328306901, 5058.873528161788, 5071.0, 5077.543021128079, 5083.38999320084, 5097.7960881564695, 5441.863953401196, 5521.3926468088475, 5531.502164805187, 5549.861253468655, 5556.611037227396, 6051.1225872248715, 6091.238595175603, 6147.44672979434, 6155.984262596666, 6174.043023331391, 6142.539309551801, 6175.042868355412, 6208.2239720034995, 6228.470580000705, 6233.189685340877, 5565.499105080481, 5700.37295897451, 5703.0589952657765, 5707.286589176353, 5742.856428589277, 6225.750969961151, 6253.155823963707, 6301.338359472281, 6311.526635502356, 6316.747330106836, 5951.880962380815, 5997.550183736237, 6004.339522652592, 6014.48876845473, 6034.879302414015, 6027.457528822427, 6204.472619827366, 6205.28639206488, 6217.191765070512, 6245.5628106033055, 5926.585139040312, 6060.33336333003, 6119.51223155561, 6122.581127188521, 6145.647957449443, 6116.914073580098, 6122.367660829195, 6136.91186679386, 6139.308154112039, 6140.3552626974415, 4765.4996225395835, 4840.733759643183, 4845.394325709286, 4853.878653033632, 4883.413990321184, 4317.266064768997, 4334.674899382559, 4342.174986752507, 4387.210302145644, 4396.296592545177, 5585.916211256835, 5624.100143976944, 5632.098864181711, 5645.040343141676, 5653.717314134276, 5993.250843644544, 6210.130581718563, 6229.875402492015, 6238.625682459067, 6241.937580624226, 5579.553635709133, 5602.38373778884, 5674.602777805597, 5703.885922281531, 5733.140028995601, 5272.340957380327, 5273.235380869753, 5282.550983166397, 5283.471652834686, 5289.920651190235, 6105.328413874381, 6320.241571011416, 6320.273168585672, 6323.5889667172405, 6328.272248691367, 5209.817656382009, 6105.186826067751, 6108.694565271808, 6216.564840461305, 6226.12834203221, 6265.655388953652, 6290.308066112632, 6297.307296197323, 6303.936960630518, 6325.9683701583035, 5911.940880591311, 6092.360302168386, 6097.5426842987845, 6103.084537319438, 6117.449429551361, 4929.950700493093, 6043.09353596964, 6097.524678803442, 6118.192813661829, 6121.788327166137, 6002.909956350571, 6038.456538911519, 6043.607165534227, 6044.969775151096, 6054.061620448838, 5843.970780146242, 5864.32560255576, 6022.126791615279, 6043.214382130295, 6047.606905551125, 5803.071508558611, 5819.330776960704, 5839.445252700986, 5856.795012174553, 5900.763969441346, 5964.850878727893, 6000.939990600213, 6004.489618382487, 6011.0, 6013.699315034319, 5620.74706638194, 5727.7422515986045, 5835.56233282497, 5835.9708201458725, 5838.416158384128], "unit": "score", "name": "dojo.html", "value": 5604.816957609733}, {"lowerIsBetter": false, "replicates": [492.4730538323995, 580.8731061740224, 581.7004242814951, 637.1525870592113, 639.2488825629887, 38177.0, 38643.42034869476, 38666.613333866655, 38705.41941870874, 38717.61282387175, 41393.7930310348, 41758.79120604401, 41916.79041604795, 41919.0, 42079.15841683172, 9348.439093654368, 9468.57391417388, 9490.430574165537, 9575.664851730191, 9583.904160958406, 9441.480718560477, 9621.855672164924, 9625.663101791439, 9636.277279204052, 9637.325387222898, 9651.662191823287, 9728.416295022285, 9736.951315243414, 9740.074692904163, 9760.316777825556, 9612.0, 9654.758631034245, 9725.465099419565, 9730.41617502945, 9734.805303893952, 9531.285153613437, 9672.08115229052, 9675.564599593035, 9679.322447428684, 9686.564104615309, 39673.0, 39905.40141897874, 40164.59835401638, 40185.59814401877, 40217.0, 3251.869925202989, 3306.123877172551, 3319.5020746887917, 3410.454327307644, 3783.4703141560203, 26498.80755366013, 26559.937602495876, 26601.46797064048, 26742.930282788664, 27055.45889082227, 2750.559910414344, 2771.0993926973815, 2775.5420355641295, 2775.6946735859037, 2833.631627888382, 418202.0, 419794.0, 419820.0, 420033.89983050193, 420519.0, 44153.11693766106, 45008.0, 61356.0, 61776.0, 62317.37682623116, 45321.0, 45519.317210241876, 45613.77193114079, 45739.0, 45826.0, 15637.921810390875, 15774.526764197093, 15806.841931580768, 15832.68334633301, 15834.12912289812, 12719.55481558141, 12764.489420423079, 12766.361681915867, 12817.743645127232, 12865.614031579067, 14430.855691443161, 14440.638984025274, 14476.34856431463, 14520.564383068524, 14621.561353159423, 5309.442508536548, 6261.467775239064, 6327.651979141099, 6381.553291269659, 6389.137466442064, 910.6266430763355, 970.8883328588727, 997.3268044070223, 1027.773889744255, 1045.592219034577, 27069.323266918484, 28067.57898631522, 28418.573721394194, 28847.71152288492, 28959.7104028957, 905.8369493491235, 1099.587654629514, 1152.4871432212753, 1155.4684844971239, 1156.9363684997406, 12347.19743216688, 12432.564860229848, 13682.726345473235, 14882.479113230986, 15027.774583381259, 478099.0, 478581.4283714376, 482880.0, 484114.0, 485373.57313213206, 56859.14711279334, 57296.42703572994, 57327.71336143293, 57400.13899791506, 57477.71261143751, 1320.399218355665, 1420.7442660321035, 1424.181095869879, 1458.023124506562, 1462.159258426409, 27862.58206126869, 28466.430671386042, 28687.35727527514, 28975.85512072426, 29316.0, 44433.77783111064, 44559.777201113786, 44817.103657926, 44852.0, 44939.775301124595, 335531.64468355005, 336056.0, 337242.0, 337436.0, 337606.0, 27823.02619408311, 31368.37263254768, 32619.83690081629, 32641.85753498616, 32657.18357041093, 39870.80064599775, 40517.0, 40650.79674601608, 40874.9781255471, 41803.7909810449, 34616.30767384689, 35220.0, 35428.93713188609, 35989.46015809713, 36211.637883620824, 33453.33093338168, 34327.82836085804, 34496.827515862264, 34923.777667781505, 35309.940701778985, 35481.0, 35697.1075723109, 35823.92528224157, 36481.0, 37631.247375052895, 30856.69143308628, 32032.83983580067, 32294.83852580722, 32336.029919102464, 32556.348873022882, 23972.88013559921, 24078.157264495658, 24666.13668521593, 24742.752572474044, 24861.751382485945], "unit": "score", "name": "ext.html", "value": 18567.691590412604}, {"lowerIsBetter": false, "replicates": [356.31942988891217, 356.60416937199705, 361.52640041545567, 368.7455655597636, 372.6943905997082, 19352.322668706598, 19478.805211947893, 20718.0, 20730.68903966438, 20760.377188684346, 19280.51798705033, 19633.0, 20228.190872365125, 20448.693269600968, 20487.795122048774, 5733.082706766918, 5821.708914554277, 5839.708014599274, 5869.530437565006, 5872.383399743029, 4191.1617676464675, 4325.74045557266, 5907.113932910076, 6186.721597528122, 6502.577332473397, 6435.742570297182, 6440.194975628046, 6445.129907462479, 6454.225492940854, 6466.676666166696, 6198.690065496752, 6297.937020629804, 6381.361863813581, 6383.840403989938, 6411.967940160316, 3699.7040236781263, 5304.840854774363, 5471.37079235885, 5523.28197334348, 5529.253550770634, 23024.0, 23480.64779028316, 23745.287641370785, 23951.16170934009, 23999.52000959971, 2194.484296190394, 2276.1805749930013, 2278.715160604924, 2314.9189778357677, 2316.397736588482, 14008.649783755385, 14294.070885392417, 14470.565883023526, 14803.555893323217, 14959.626009349853, 1682.6718789835986, 1780.3590707345345, 1800.7839059312835, 1811.845993090589, 1820.9271629134819, 82436.0, 85058.57470712607, 92442.53778731063, 92720.0, 92929.0, 8973.865392019125, 10764.677059688222, 10868.836967445495, 11047.613333533287, 11069.557217711363, 13416.0, 13477.460901563827, 13482.460701572023, 13485.730285394236, 13514.256715880525, 8178.345732341399, 8315.501069935823, 8345.582720863933, 8435.144268260972, 8441.240288374076, 6744.5616034957575, 8369.665213391396, 8383.832323353621, 8496.235338819535, 8497.915020849836, 4265.445492086071, 4356.128774245164, 4369.694121411534, 4389.934150987738, 4407.140607581491, 1575.5430925031612, 1690.1464760295971, 1778.8399044086095, 1787.8390944814769, 1791.3461586520825, 869.4218344800763, 884.4737381258141, 916.6791622932054, 917.2936838634214, 1031.9484025798681, 17939.37212197567, 18389.26442942294, 19073.523161920784, 19089.809101909083, 19202.711959320623, 941.4727752458645, 965.5172413793103, 968.8352979993418, 970.2383628851318, 1008.6016023670755, 10136.645217417356, 10539.42033188182, 10561.0, 10568.471576421149, 10611.681649550526, 473499.0, 483302.0, 485620.0, 573778.0, 592311.0, 67833.66083169552, 78966.0, 100871.0, 101567.0, 110335.0, 991.2862738828032, 1013.9594416223416, 1028.321307936773, 1031.4945676618404, 1035.063267742694, 17348.566285842953, 17435.50388446743, 17443.738343924597, 17774.20016099253, 18046.5488362792, 48976.755116224194, 50098.49901501084, 50582.49417505925, 50801.49198507968, 50983.745081274355, 64442.677786610766, 66683.57451887138, 70252.0, 71083.28916710766, 71552.9267061005, 7463.179050304354, 7679.884801727867, 7754.495957762728, 7820.3743700504965, 7838.372930165687, 8888.777780555538, 11394.658160255205, 11920.880791191978, 12293.569725059937, 12377.443015064524, 10459.320144190908, 10459.64024676787, 10719.785604288027, 10843.783124337311, 10909.672709818718, 8876.778080548038, 9152.63389464414, 10200.0, 10278.794424111626, 10330.276880618285, 10489.213309002009, 10553.0, 10557.841632375674, 10726.946365268124, 10952.890471095187, 7534.698612055676, 7624.656890439833, 7723.884141737766, 7746.225377462209, 7912.406569507195, 8599.527026013378, 10325.896741032793, 10410.375377477376, 10582.894171058191, 10630.681079567625], "unit": "score", "name": "jquery.html", "value": 9108.78332315311}, {"lowerIsBetter": false, "replicates": [1437.209534755884, 1569.2075501871552, 1604.7913771209742, 1863.310575087218, 1998.8101130392608, 7828.60856957152, 8457.746267611974, 8624.180702833228, 8632.870506942385, 8660.480371177719, 8397.412181147321, 8568.614412351444, 8585.14148585141, 8597.785055373619, 8599.871001934976, 2417.117752020513, 2451.48518811049, 2451.656768052474, 2452.16626347042, 2457.680501534807, 2422.9030838766516, 2431.0640403444622, 2480.7519248075137, 2484.7266800651914, 2495.962560561584, 2437.8293519453646, 2454.3864033991504, 2483.615039668854, 2487.253823852846, 2488.2410864686262, 2444.046821739523, 2455.3002394317623, 2465.827392082546, 2480.7147178074574, 2480.8263421560496, 2427.5023620157826, 2456.1894574790276, 2463.224084413404, 2466.260121963404, 2486.676732024825, 8690.913090869073, 8716.651333946635, 8733.301335893113, 8737.519436430994, 8749.912500874974, 4614.561616646413, 5265.131253343194, 5453.127499600045, 5465.207544905967, 5470.370907345667, 3485.4771784232566, 3599.1541987632886, 3627.818609069536, 3649.8540058397634, 3665.083729067733, 1036.461040259061, 1047.9109275711573, 1048.501961568249, 1055.4669891704716, 1060.671191930504, 11700.0, 11710.355930423822, 11730.765384692259, 11737.295762254293, 11739.941300293529, 4832.081904438216, 4832.903341933212, 4858.5384388483035, 4905.386826646669, 4916.483769204254, 9943.204543636492, 9957.103860652576, 9968.252381071448, 9971.950140249251, 9975.800483990424, 5441.156620723794, 5449.836504904859, 5450.100733379028, 5450.400455949843, 5460.645058071292, 4432.202203603318, 4525.117602067631, 4526.59260666535, 4531.796069176895, 4950.950490495049, 3677.338079145726, 3822.9426558601645, 3852.8844134676006, 3866.7679939203176, 3874.1089549403796, 1203.5136606291223, 1219.7194645231468, 1279.0854539004656, 1281.1224311346757, 1291.8643542428097, 1320.933953302331, 1324.245180247269, 1355.1327150623608, 1362.3596909452542, 1363.4205462678322, 7882.014748156481, 7928.524288542706, 8035.316998055114, 8050.838983220303, 8084.312833409226, 1172.3141961952354, 1186.6262127429832, 1193.1409385242785, 1201.375284851872, 1218.981715274254, 6049.818505444844, 6156.26124865019, 6173.135760993465, 6175.2589689237575, 6180.196574445384, 9604.807903842024, 10019.148372388283, 10044.347117437343, 10169.847452288222, 10185.796284074426, 9758.853617195748, 9998.900010999796, 10048.748781280381, 10062.446565438824, 10088.546015429323, 8164.142765009708, 8283.710070147516, 8339.45793523419, 8347.874781878276, 8361.874571881426, 7883.5664038478435, 7901.762947111596, 8074.1522140176785, 8085.9595702021115, 8169.428140030379, 8885.644574217218, 9251.907480925105, 9533.713988580077, 9624.951875240578, 9635.662751803653, 9231.676891308773, 9478.194353480032, 9504.619815207314, 9556.426614403159, 9710.70867873965, 7366.852662946604, 7394.44716609518, 7480.925190748023, 7512.661930213263, 7513.849723005618, 8003.879941800761, 8059.194080591894, 8098.75703728889, 8121.67513299485, 8138.4303098784885, 7347.55914645123, 7366.558006519626, 7394.741184058532, 7506.774796756106, 7515.586642734702, 6157.291911430064, 7197.856042879218, 7204.919262110725, 7294.890576641461, 7362.22696616869, 7320.707171713285, 7630.1606823248285, 7634.351080158027, 7641.808954776175, 7732.690692372467, 6896.655167241718, 6939.861202775815, 6955.826104347229, 6965.373116419547, 6968.651567421507, 6981.162260528769, 6998.055262539492, 7016.228214896255, 7017.754378596725, 7072.328128827753], "unit": "score", "name": "mootools.html", "value": 4902.4598134357}, {"lowerIsBetter": false, "replicates": [321.1489552685383, 325.50523204728813, 330.8593847614764, 332.5460746081599, 336.23338787564364, 6460.353964603543, 6542.96728516358, 6548.869022619545, 6581.5721978071515, 6585.83535411615, 6445.162128923245, 6528.183977002875, 6528.510361722878, 6530.314316996706, 6536.934630653692, 4604.769761511911, 4695.389599352079, 4720.12677654635, 4819.590334821527, 4857.659963802526, 4812.807487700487, 4822.204336284526, 4837.7822997965, 4845.927311090337, 4846.200376937801, 4799.664023518355, 4801.159797035522, 4801.61587073035, 4814.205656066745, 4824.0834241494, 4567.497575266718, 4700.529947005272, 4714.080754252922, 4726.598239149642, 4822.879428014293, 4004.7196696231276, 4068.6338229559483, 4097.955021469536, 4102.015516276102, 4102.815373308208, 6155.353687862755, 6188.071789231606, 6230.906536401958, 6233.470155036827, 6239.937600624026, 5598.692071936042, 5599.524040456566, 5608.065217499956, 5608.635438696512, 5610.607257491977, 6842.281560436182, 6856.554323968976, 6864.279250678706, 6867.828304292432, 6877.4841886858685, 3805.429185622151, 4461.24158892989, 4619.053094115732, 4625.8149674013, 4637.072585482883, 6419.3259707730485, 6519.315471875432, 7101.857962840766, 7156.821079473003, 7201.711931522733, 3872.6320999505, 4704.317873908264, 4728.763561821896, 4729.527047295312, 4729.6689231754135, 4784.378030855966, 4809.735464549413, 4813.927791083137, 4822.0, 4822.807087716522, 5598.10430331145, 5602.495775380154, 5602.6918519481005, 5602.943970560243, 5611.6071874969175, 6613.603183808987, 6862.0, 6866.416354609814, 6883.208431030395, 6894.965525172342, 1652.2647421897382, 1656.5858535366158, 1670.7076261654404, 1672.5567724553002, 1674.3637417781165, 1082.3127314155568, 1085.978280434387, 1106.3140852671233, 1110.1895616200059, 1111.8721347045032, 6301.180846489927, 6480.870382592416, 6482.513811464159, 6515.804525864137, 6517.478601711851, 7070.611116388648, 7082.433405327562, 7090.751823686146, 7104.147502299757, 7121.252268511732, 6303.7793677222, 6436.066770318372, 6493.805185844432, 6547.758859364645, 6567.540272180997, 3766.2844059628583, 3802.7718336899875, 3805.8667946621736, 3820.522434695663, 3823.1971286030243, 6191.783287585003, 7241.348278654947, 7517.060367454068, 7522.511036782701, 7563.205863384375, 5962.22491076166, 7427.145878223965, 7432.368248698813, 7435.888461673079, 7441.627918604048, 7463.253674632493, 7506.774796756106, 7518.0, 7536.359409450258, 7544.886826697604, 5462.945370546403, 7159.03353047332, 7162.677679504539, 7168.426525877813, 7179.317964793337, 6752.155980502437, 7040.718371265092, 7040.964795175992, 7043.647817609201, 7068.752593659197, 7504.662290196845, 7509.887351689838, 7530.623468826647, 7530.774076777706, 7539.773806785805, 4118.649914757159, 4702.670813043054, 4739.123262196505, 4744.644151688568, 4751.239801631722, 7153.785386438415, 7156.713731450892, 7174.0, 7179.569225846466, 7184.389326907062, 5998.820035398945, 6281.59169653971, 6913.619750913748, 6931.2375638678695, 6942.305769423017, 5631.2960879890015, 6908.585484870924, 6921.2732663069655, 6924.515283930076, 6930.930690693029, 6703.966480167763, 6746.4265537429865, 6769.4922880785125, 6777.220619628806, 6781.728730850711, 5713.828585142286, 6848.931510685029, 6932.826679333057, 6932.930670693228, 6958.721651133898, 6497.480201583957, 6759.0, 6764.526483146133, 6774.898376524257, 6809.114815074008], "unit": "score", "name": "prototype.html", "value": 5063.635487289214}, {"lowerIsBetter": false, "replicates": [666.5201055240227, 701.424831638057, 747.2639450141613, 758.8861670749387, 784.6273020315349, 14823.184724840143, 15148.848511514881, 15222.238888055608, 15245.856560757931, 15262.160581168031, 12515.186512876679, 13988.65028374291, 14053.437862485514, 14063.0, 14092.43630254791, 911.5077857956695, 940.9482478463682, 944.6221511395462, 945.6217512994823, 945.8486642137259, 923.3075193604797, 930.0188301342081, 934.7569631895722, 936.3819878879941, 937.8968313485511, 780.574586850168, 814.6741303478597, 974.1573538888881, 996.1084829077971, 999.2505620784411, 986.0780170540568, 986.2061040862103, 988.9703308900672, 989.678354534779, 989.7525618595315, 733.9302766237199, 734.2437289591729, 734.7097896330973, 735.6395366270542, 736.4439847914844, 14759.557213283619, 14855.182964936925, 14864.851351486455, 14870.553883383516, 14874.851251487455, 12396.56612018584, 12633.557825476157, 12750.10749247553, 12851.293178875158, 12943.935280323632, 9810.75473113178, 10021.0, 10284.845727314096, 10358.948205258925, 10568.682939511827, 3341.465365541526, 3343.8996830095134, 3348.41402754517, 3352.5661095622145, 3392.77946933451, 81099.59450202712, 81745.18254817436, 81852.0, 82592.0, 82908.3418331636, 9494.572744226527, 9507.286953478517, 9575.664851730156, 9725.6596019139, 9823.950880245553, 20644.0, 20939.68590471144, 22314.776852231593, 22367.0, 22387.0, 7459.440541959375, 7470.252974702595, 7520.586367749826, 7719.845603087907, 7845.921540784633, 3895.649391554717, 3974.0, 4006.358982562834, 4038.030872590557, 4047.5952404759287, 3545.2732189901008, 3598.956302672248, 3604.693601043888, 3607.206414588786, 3608.1881576645046, 629.0752593687272, 629.4429429954523, 641.5156556799586, 661.7419206509466, 664.6244871647503, 529.993013274781, 540.1096163428002, 592.2448877680991, 600.639616230267, 609.7926704920349, 7776.222377762178, 7902.4863383879865, 7976.202379761978, 8172.836543269102, 8340.04089529712, 512.9487051294915, 516.790709739212, 539.641138642806, 566.5189293584634, 592.943670351316, 3774.584795672474, 3776.169242766587, 3830.2148059647707, 3834.501514803058, 4025.6376926076796, 84993.57503212444, 85100.0, 85298.0, 86486.0, 87318.56340718256, 61043.08435373473, 75191.0, 75648.62175689197, 76228.61885690536, 76778.61610691911, 64016.67991660012, 64712.02931956024, 65120.0, 65193.0, 65703.67148164324, 7709.190534993745, 7718.382529397747, 7806.960965195365, 7916.683332666629, 7924.9207507926485, 46888.765556172, 47873.04253914832, 48418.5158148414, 48778.75610622066, 49401.75299123481, 60505.0, 64004.35995639984, 65622.34377656163, 65711.0, 66464.67070658656, 9782.119609235204, 9957.402555846673, 9973.45146016947, 10068.496575171359, 10218.897811021794, 8560.160534053763, 8658.826823463369, 10805.351678899291, 10975.28660637056, 11652.650420487398, 11029.944850275697, 11185.776284474428, 11365.48855301497, 11421.543138274375, 11545.134114941246, 11142.108631309638, 11150.776984460428, 11168.888311116785, 11517.424128793695, 11563.421828908353, 10812.189085818438, 10905.563777448813, 11131.499082541142, 11291.548338066385, 11307.830382544433, 9318.18181818171, 9351.672691455766, 9404.828189627657, 9735.659251926148, 9926.354786938826, 9246.899928915525, 9632.13310802003, 9646.42121472714, 9659.32384733062, 9674.0], "unit": "score", "name": "yui.html", "value": 6788.016707384134}], "name": "dromaeo_css", "value": 7366.118561406987}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 110.0, 112.0, 108.0, 112.0, 115.0, 111.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [157.0, 126.0, 144.0, 159.0, 140.0, 173.0, 173.0, 117.0, 192.0, 105.0], "unit": "score", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [189.0, 185.0, 183.0, 185.0, 187.0, 186.0, 183.0, 179.0, 181.0, 180.0], "unit": "score", "name": "audio-dft", "value": 183.8}, {"lowerIsBetter": true, "replicates": [76.0, 72.0, 84.0, 79.0, 56.0, 58.0, 59.0, 77.0, 79.0, 56.0], "unit": "score", "name": "audio-fft", "value": 69.6}, {"lowerIsBetter": true, "replicates": [94.0, 97.0, 126.0, 78.0, 77.0, 79.0, 111.0, 79.0, 78.0, 111.0], "unit": "score", "name": "audio-oscillator", "value": 93.0}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 88.0, 84.0, 87.0, 84.0, 89.0, 84.0, 88.0, 87.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.4}, {"lowerIsBetter": true, "replicates": [133.0, 148.0, 93.0, 96.0, 92.0, 93.0, 93.0, 93.0, 93.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 102.6}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 85.0, 85.0, 85.0, 86.0, 85.0, 87.0, 86.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.3}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 54.0, 55.0, 55.0, 56.0, 57.0, 66.0, 55.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 56.3}, {"lowerIsBetter": true, "replicates": [63.0, 69.0, 67.0, 72.0, 69.0, 66.0, 66.0, 65.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 83.0, 83.0, 84.0, 81.0, 84.0, 83.0, 84.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [121.0, 114.0, 133.0, 123.0, 132.0, 123.0, 133.0, 120.0, 127.0, 133.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.9}, {"lowerIsBetter": true, "replicates": [141.0, 128.0, 141.0, 140.0, 137.0, 129.0, 141.0, 140.0, 137.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 66.0, 67.0, 66.0, 67.0, 67.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1417.6000000000001}]} 22:24:45 INFO - Return code: 0 22:24:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:24:45 ERROR - # TBPL SUCCESS # 22:24:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:24:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:24:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:24:45 INFO - 2016-04-05 22:24:45.905 screenresolution[1677:9633] starting screenresolution argv=screenresolution get 22:24:45 INFO - 2016-04-05 22:24:45.909 screenresolution[1677:9633] Display 0: 1600x1200x32@60 22:24:45 INFO - 2016-04-05 22:24:45.915 screenresolution[1678:9636] starting screenresolution argv=screenresolution list 22:24:45 INFO - Available Modes on Display 0 22:24:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:24:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:24:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:24:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:24:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:24:46 INFO - Intel Iris: 22:24:46 INFO - Chipset Model: Intel Iris 22:24:46 INFO - Type: GPU 22:24:46 INFO - Bus: Built-In 22:24:46 INFO - VRAM (Dynamic, Max): 1536 MB 22:24:46 INFO - Vendor: Intel (0x8086) 22:24:46 INFO - Device ID: 0x0a2e 22:24:46 INFO - Revision ID: 0x0009 22:24:46 INFO - Displays: 22:24:46 INFO - Display: 22:24:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:24:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:24:46 INFO - Display Serial Number: 1600x1200 60 22:24:46 INFO - Main Display: Yes 22:24:46 INFO - Mirror: Off 22:24:46 INFO - Online: Yes 22:24:46 INFO - Rotation: Supported 22:24:46 INFO - Return code: 0 22:24:46 INFO - Running post-action listener: _resource_record_post_action 22:24:46 INFO - Running post-run listener: _resource_record_post_run 22:24:47 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 37123584; Write bytes: 701157888; Read time: 394; Write time: 2276 22:24:47 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 388557312; Write bytes: 382453248; Read time: 29772; Write time: 939 22:24:47 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 36169216; Write bytes: 297884672; Read time: 379; Write time: 1293 22:24:47 INFO - Running post-run listener: _upload_blobber_files 22:24:47 INFO - Blob upload gear active. 22:24:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:24:47 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 22:24:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:24:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:24:47 INFO - (blobuploader) - INFO - Open directory for files ... 22:24:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:24:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:24:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:24:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:24:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:24:50 INFO - (blobuploader) - INFO - Done attempting. 22:24:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:24:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:24:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:24:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:24:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:24:51 INFO - (blobuploader) - INFO - Done attempting. 22:24:51 INFO - (blobuploader) - INFO - Iteration through files over. 22:24:51 INFO - Return code: 0 22:24:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:24:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:24:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec7e90885bc2849dbd4b0422ffa0c701f7ef3fa2b7a9158ea8e2a2ff18836078ae287418b9ff04990b60c1f213663a0dbaed20938f3db3882831d58a08b88ed2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e55e0975927004744adfbd1b5c5fc7f42ee5f1862287acf7da36d6d5c48326be11c943f803986c1430c314f90ac999db229e98d66d6ebafaad916d405ecaef87"} 22:24:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:24:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:24:51 INFO - Contents: 22:24:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec7e90885bc2849dbd4b0422ffa0c701f7ef3fa2b7a9158ea8e2a2ff18836078ae287418b9ff04990b60c1f213663a0dbaed20938f3db3882831d58a08b88ed2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e55e0975927004744adfbd1b5c5fc7f42ee5f1862287acf7da36d6d5c48326be11c943f803986c1430c314f90ac999db229e98d66d6ebafaad916d405ecaef87"} 22:24:51 INFO - Running post-run listener: copy_logs_to_upload_dir 22:24:51 INFO - Copying logs to upload dir... 22:24:51 INFO - mkdir: /builds/slave/test/build/upload/logs 22:24:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.570334 ========= master_lag: 5.76 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-04-05 22:24:57.452212) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 22:24:57.457075) ========= 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.KRvsnaa25I/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.DOHWQjpfId/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec7e90885bc2849dbd4b0422ffa0c701f7ef3fa2b7a9158ea8e2a2ff18836078ae287418b9ff04990b60c1f213663a0dbaed20938f3db3882831d58a08b88ed2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e55e0975927004744adfbd1b5c5fc7f42ee5f1862287acf7da36d6d5c48326be11c943f803986c1430c314f90ac999db229e98d66d6ebafaad916d405ecaef87"} build_url:https://queue.taskcluster.net/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011695 build_url: 'https://queue.taskcluster.net/v1/task/AGqzypb6TIy9CN2OJ76wGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec7e90885bc2849dbd4b0422ffa0c701f7ef3fa2b7a9158ea8e2a2ff18836078ae287418b9ff04990b60c1f213663a0dbaed20938f3db3882831d58a08b88ed2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e55e0975927004744adfbd1b5c5fc7f42ee5f1862287acf7da36d6d5c48326be11c943f803986c1430c314f90ac999db229e98d66d6ebafaad916d405ecaef87"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 22:24:57.500363) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 22:24:57.500650) ========= 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.KRvsnaa25I/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.DOHWQjpfId/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.005290 ========= master_lag: 0.27 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 22:24:57.774109) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 22:24:57.774417) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 22:24:57.775114) ========= ========= Total master_lag: 6.27 =========