builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0186 starttime: 1458139655.63 results: success (0) buildid: 20160316064345 builduid: fb8c8e7bbeff41569631b284a0359cd5 revision: 360e21e14e09be0c9aa607a0d7d256b0f5a2bc5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 07:47:35.627953) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 07:47:35.631695) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 07:47:35.632228) ========= 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.9c2loKL8iY/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.OfDHTjqTqo/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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.005870 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 07:47:35.665474) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 07:47:35.665837) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 07:47:35.684961) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 07:47:35.685290) ========= 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.9c2loKL8iY/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.OfDHTjqTqo/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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.005435 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 07:47:35.733774) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 07:47:35.737121) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 07:47:35.737507) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 07:47:35.737793) ========= 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.9c2loKL8iY/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.OfDHTjqTqo/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-16 07:47:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-03-16 07:47:35 (46.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157377 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 07:47:35.914468) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 07:47:35.914802) ========= 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.9c2loKL8iY/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.OfDHTjqTqo/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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.019693 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 07:47:35.964338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-16 07:47:35.964706) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 360e21e14e09be0c9aa607a0d7d256b0f5a2bc5b --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 360e21e14e09be0c9aa607a0d7d256b0f5a2bc5b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9c2loKL8iY/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.OfDHTjqTqo/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-16 07:47:36,034 truncating revision to first 12 chars 2016-03-16 07:47:36,034 Setting DEBUG logging. 2016-03-16 07:47:36,035 attempt 1/10 2016-03-16 07:47:36,035 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/360e21e14e09?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-16 07:47:37,563 unpacking tar archive at: fx-team-360e21e14e09/testing/mozharness/ program finished with exit code 0 elapsedTime=1.772195 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-16 07:47:37.755440) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 07:47:37.756050) ========= echo 360e21e14e09be0c9aa607a0d7d256b0f5a2bc5b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'360e21e14e09be0c9aa607a0d7d256b0f5a2bc5b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9c2loKL8iY/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.OfDHTjqTqo/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 360e21e14e09be0c9aa607a0d7d256b0f5a2bc5b program finished with exit code 0 elapsedTime=0.005192 script_repo_revision: '360e21e14e09be0c9aa607a0d7d256b0f5a2bc5b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 07:47:37.808964) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 07:47:37.809274) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 07:47:37.823347) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-03-16 07:47:37.823623) ========= /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.9c2loKL8iY/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.OfDHTjqTqo/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 07:47:37 INFO - MultiFileLogger online at 20160316 07:47:37 in /builds/slave/test 07:47:37 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 07:47:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:47:37 INFO - {'append_to_log': False, 07:47:37 INFO - 'base_work_dir': '/builds/slave/test', 07:47:37 INFO - 'blob_upload_branch': 'Fx-Team', 07:47:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:47:37 INFO - 'branch': 'Fx-Team', 07:47:37 INFO - 'buildbot_json_path': 'buildprops.json', 07:47:37 INFO - 'config_files': ('talos/mac_config.py',), 07:47:37 INFO - 'default_actions': ('clobber', 07:47:37 INFO - 'read-buildbot-config', 07:47:37 INFO - 'download-and-extract', 07:47:37 INFO - 'populate-webroot', 07:47:37 INFO - 'create-virtualenv', 07:47:37 INFO - 'install', 07:47:37 INFO - 'run-tests'), 07:47:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:47:37 INFO - 'download_minidump_stackwalk': True, 07:47:37 INFO - 'download_symbols': 'ondemand', 07:47:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:47:37 INFO - 'tooltool.py': '/tools/tooltool.py', 07:47:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:47:37 INFO - '/tools/misc-python/virtualenv.py')}, 07:47:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:47:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:47:37 INFO - 'installer_path': 'installer.exe', 07:47:37 INFO - 'log_level': 'info', 07:47:37 INFO - 'log_name': 'talos', 07:47:37 INFO - 'log_to_console': True, 07:47:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:47:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:47:37 INFO - 'opt_config_files': (), 07:47:37 INFO - 'pip_index': False, 07:47:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:47:37 INFO - 'cmd': ('bash', 07:47:37 INFO - '-c', 07:47:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:47:37 INFO - 'enabled': True, 07:47:37 INFO - 'halt_on_failure': False, 07:47:37 INFO - 'name': 'check_screen_resolution'},), 07:47:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:47:37 INFO - 'cmd': ('bash', 07:47:37 INFO - '-c', 07:47:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:47:37 INFO - 'enabled': True, 07:47:37 INFO - 'halt_on_failure': False, 07:47:37 INFO - 'name': 'check_screen_resolution'},), 07:47:37 INFO - 'run_cmd_checks_enabled': True, 07:47:37 INFO - 'sps_profile': False, 07:47:37 INFO - 'sps_profile_interval': 0, 07:47:37 INFO - 'suite': 'dromaeojs', 07:47:38 INFO - 'system_bits': '32', 07:47:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:47:38 INFO - 'title': 't-yosemite-r7-0186', 07:47:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:47:38 INFO - 'use_talos_json': True, 07:47:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:47:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:47:38 INFO - 'work_dir': 'build'} 07:47:38 INFO - ##### 07:47:38 INFO - ##### Running clobber step. 07:47:38 INFO - ##### 07:47:38 INFO - Running pre-action listener: _resource_record_pre_action 07:47:38 INFO - Running main action method: clobber 07:47:38 INFO - rmtree: /builds/slave/test/build 07:47:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:47:38 INFO - Running post-action listener: _resource_record_post_action 07:47:38 INFO - ##### 07:47:38 INFO - ##### Running read-buildbot-config step. 07:47:38 INFO - ##### 07:47:38 INFO - Running pre-action listener: _resource_record_pre_action 07:47:38 INFO - Running main action method: read_buildbot_config 07:47:38 INFO - Using buildbot properties: 07:47:38 INFO - { 07:47:38 INFO - "project": "", 07:47:38 INFO - "product": "firefox", 07:47:38 INFO - "script_repo_revision": "production", 07:47:38 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 07:47:38 INFO - "repository": "", 07:47:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 07:47:38 INFO - "buildid": "20160316064345", 07:47:38 INFO - "pgo_build": "False", 07:47:38 INFO - "basedir": "/builds/slave/test", 07:47:38 INFO - "buildnumber": 540, 07:47:38 INFO - "slavename": "t-yosemite-r7-0186", 07:47:38 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:47:38 INFO - "platform": "yosemite_r7", 07:47:38 INFO - "scheduler": "tests-fx-team-macosx64-talos", 07:47:38 INFO - "branch": "fx-team", 07:47:38 INFO - "repo_path": "integration/fx-team", 07:47:38 INFO - "revision": "360e21e14e09be0c9aa607a0d7d256b0f5a2bc5b", 07:47:38 INFO - "stage_platform": "macosx64", 07:47:38 INFO - "builduid": "fb8c8e7bbeff41569631b284a0359cd5", 07:47:38 INFO - "slavebuilddir": "test" 07:47:38 INFO - } 07:47:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 07:47:38 INFO - Running post-action listener: _resource_record_post_action 07:47:38 INFO - ##### 07:47:38 INFO - ##### Running download-and-extract step. 07:47:38 INFO - ##### 07:47:38 INFO - Running pre-action listener: _resource_record_pre_action 07:47:38 INFO - Running main action method: download_and_extract 07:47:38 INFO - mkdir: /builds/slave/test/build/tests 07:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:47:38 INFO - https://queue.taskcluster.net/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:47:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:47:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:47:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/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 07:47:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/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 07:47:39 INFO - Downloaded 1199 bytes. 07:47:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 07:47:39 INFO - Using the following test package requirements: 07:47:39 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:47:39 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:47:39 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 07:47:39 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:47:39 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 07:47:39 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:47:39 INFO - u'jsshell-mac.zip'], 07:47:39 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:47:39 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 07:47:39 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:47:39 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:47:39 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 07:47:39 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:47:39 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 07:47:39 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:47:39 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 07:47:39 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:47:39 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 07:47:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:47:39 INFO - https://queue.taskcluster.net/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:47:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:47:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:47:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/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 07:47:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/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 07:47:40 INFO - Downloaded 17854406 bytes. 07:47:40 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'] 07:47:40 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 07:47:43 INFO - Return code: 0 07:47:43 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 07:47: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')]} 07:47:43 INFO - https://queue.taskcluster.net/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:47:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:47:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:47:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/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 07:47:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/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 07:47:44 INFO - Downloaded 17854406 bytes. 07:47:44 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'] 07:47:44 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 07:47:48 INFO - Return code: 0 07:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:47:48 INFO - https://queue.taskcluster.net/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:47:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:47:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:47:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/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 07:47:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/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 07:47:49 INFO - Downloaded 10846462 bytes. 07:47:49 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'] 07:47:49 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 07:47:49 INFO - Return code: 0 07:47: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')]} 07:47:49 INFO - https://queue.taskcluster.net/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:47:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:47:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:47:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 07:47:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MooP50vhQACR9nYeUxMfMQ/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 07:47:52 INFO - Downloaded 111197712 bytes. 07:47:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:47:52 INFO - mkdir: /builds/slave/test/properties 07:47:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:47:52 INFO - Writing to file /builds/slave/test/properties/build_url 07:47:52 INFO - Contents: 07:47:52 INFO - build_url:https://queue.taskcluster.net/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:47:53 INFO - Running post-action listener: _resource_record_post_action 07:47:53 INFO - Running post-action listener: set_extra_try_arguments 07:47:53 INFO - ##### 07:47:53 INFO - ##### Running populate-webroot step. 07:47:53 INFO - ##### 07:47:53 INFO - Running pre-action listener: _resource_record_pre_action 07:47:53 INFO - Running main action method: populate_webroot 07:47:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:47:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:47:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:47:53 INFO - '--tppagecycles', 07:47:53 INFO - '7'], 07:47:53 INFO - 'tests': ['tsvgm']}}, 07:47:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:47:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:47:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:47:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:47:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:47:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:47:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:47:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:53 INFO - 'talos_options': ['--e10s'], 07:47:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:47:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:53 INFO - 'tests': ['damp', 'tps']}, 07:47:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:53 INFO - 'talos_options': ['--e10s'], 07:47:53 INFO - 'tests': ['damp', 'tps']}, 07:47:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:47:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:47:53 INFO - 'other': {'tests': ['a11yr', 07:47:53 INFO - 'ts_paint', 07:47:53 INFO - 'tpaint', 07:47:53 INFO - 'sessionrestore', 07:47:53 INFO - 'sessionrestore_no_auto_restore', 07:47:53 INFO - 'tabpaint']}, 07:47:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:47:53 INFO - 'tests': ['a11yr', 07:47:53 INFO - 'ts_paint', 07:47:53 INFO - 'tpaint', 07:47:53 INFO - 'sessionrestore', 07:47:53 INFO - 'sessionrestore_no_auto_restore', 07:47:53 INFO - 'tabpaint']}, 07:47:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:47:53 INFO - 'tests': ['a11yr', 07:47:53 INFO - 'ts_paint', 07:47:53 INFO - 'tpaint', 07:47:53 INFO - 'sessionrestore', 07:47:53 INFO - 'sessionrestore_no_auto_restore', 07:47:53 INFO - 'tabpaint']}, 07:47:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:47:53 INFO - 'tests': ['a11yr', 07:47:53 INFO - 'ts_paint', 07:47:53 INFO - 'tpaint', 07:47:53 INFO - 'sessionrestore', 07:47:53 INFO - 'sessionrestore_no_auto_restore', 07:47:53 INFO - 'tabpaint']}, 07:47:53 INFO - 'other_l64': {'tests': ['a11yr', 07:47:53 INFO - 'ts_paint', 07:47:53 INFO - 'tpaint', 07:47:53 INFO - 'sessionrestore', 07:47:53 INFO - 'sessionrestore_no_auto_restore', 07:47:53 INFO - 'tabpaint']}, 07:47:53 INFO - 'other_nol64': {'tests': ['a11yr', 07:47:53 INFO - 'ts_paint', 07:47:53 INFO - 'tpaint', 07:47:53 INFO - 'sessionrestore', 07:47:53 INFO - 'sessionrestore_no_auto_restore', 07:47:53 INFO - 'tabpaint']}, 07:47:53 INFO - 'svgr': {'tests': ['tsvgx', 07:47:53 INFO - 'tsvgr_opacity', 07:47:53 INFO - 'tart', 07:47:53 INFO - 'tscrollx', 07:47:53 INFO - 'cart']}, 07:47:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:47:53 INFO - 'tests': ['tsvgx', 07:47:53 INFO - 'tsvgr_opacity', 07:47:53 INFO - 'tart', 07:47:53 INFO - 'tscrollx', 07:47:53 INFO - 'cart']}, 07:47:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:53 INFO - 'tests': ['tp5o']}, 07:47:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:53 INFO - 'talos_options': ['--e10s'], 07:47:53 INFO - 'tests': ['tp5o']}, 07:47:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:53 INFO - 'talos_options': ['--xperf_path', 07:47:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:47:53 INFO - 'tests': ['tp5n']}, 07:47:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:53 INFO - 'talos_options': ['--e10s', 07:47:53 INFO - '--xperf_path', 07:47:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:47:53 INFO - 'tests': ['tp5n']}}, 07:47:53 INFO - 'talos.zip': {'path': '', 07:47:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:47:53 INFO - Running post-action listener: _resource_record_post_action 07:47:53 INFO - ##### 07:47:53 INFO - ##### Running create-virtualenv step. 07:47:53 INFO - ##### 07:47:53 INFO - Running pre-action listener: _resource_record_pre_action 07:47:53 INFO - Running main action method: create_virtualenv 07:47:53 INFO - Creating virtualenv /builds/slave/test/build/venv 07:47:53 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 07:47:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:47:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:47:53 INFO - Using real prefix '/tools/python27' 07:47:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:47:54 INFO - Installing distribute.............................................................................................................................................................................................done. 07:47:57 INFO - Installing pip.................done. 07:47:57 INFO - Return code: 0 07:47:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:47:57 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')]} 07:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:57 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')]} 07:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:57 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 0x100bada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bb54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdaacbdec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a51d30>, '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 0x100875db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a48b20>, '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.9c2loKL8iY/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.OfDHTjqTqo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 07:47:57 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 07:47:57 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 07:47:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9c2loKL8iY/Render', 07:47:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:57 INFO - 'HOME': '/Users/cltbld', 07:47:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:57 INFO - 'LOGNAME': 'cltbld', 07:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:57 INFO - 'MOZ_NO_REMOTE': '1', 07:47:57 INFO - 'NO_EM_RESTART': '1', 07:47:57 INFO - 'PAGER': '/bin/cat', 07:47:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:57 INFO - 'PWD': '/builds/slave/test', 07:47:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:57 INFO - 'SHELL': '/bin/bash', 07:47:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OfDHTjqTqo/Listeners', 07:47:57 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 07:47:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:57 INFO - 'USER': 'cltbld', 07:47:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:57 INFO - 'XPC_FLAGS': '0x0', 07:47:57 INFO - 'XPC_SERVICE_NAME': '0', 07:47:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:57 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 07:47:57 INFO - Cleaning up... 07:47:57 INFO - Return code: 0 07:47:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:47:57 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')]} 07:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:57 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')]} 07:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:57 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 0x100bada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bb54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdaacbdec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a51d30>, '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 0x100875db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a48b20>, '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.9c2loKL8iY/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.OfDHTjqTqo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 07:47:57 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 07:47:57 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 07:47:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9c2loKL8iY/Render', 07:47:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:57 INFO - 'HOME': '/Users/cltbld', 07:47:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:57 INFO - 'LOGNAME': 'cltbld', 07:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:57 INFO - 'MOZ_NO_REMOTE': '1', 07:47:57 INFO - 'NO_EM_RESTART': '1', 07:47:57 INFO - 'PAGER': '/bin/cat', 07:47:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:57 INFO - 'PWD': '/builds/slave/test', 07:47:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:57 INFO - 'SHELL': '/bin/bash', 07:47:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OfDHTjqTqo/Listeners', 07:47:57 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 07:47:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:57 INFO - 'USER': 'cltbld', 07:47:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:57 INFO - 'XPC_FLAGS': '0x0', 07:47:57 INFO - 'XPC_SERVICE_NAME': '0', 07:47:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:57 INFO - Downloading/unpacking psutil>=0.7.1 07:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:48:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:48:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:48:00 INFO - Installing collected packages: psutil 07:48:00 INFO - Running setup.py install for psutil 07:48:00 INFO - building 'psutil._psutil_osx' extension 07:48:00 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 07:48:00 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 07:48:01 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 07:48:01 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 07:48:01 INFO - building 'psutil._psutil_posix' extension 07:48:01 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 07:48:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:48:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:48:01 INFO - ^ 07:48:01 INFO - 1 warning generated. 07:48:01 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 07:48:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:48:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:48:01 INFO - Successfully installed psutil 07:48:01 INFO - Cleaning up... 07:48:01 INFO - Return code: 0 07:48:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100bada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bb54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdaacbdec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a51d30>, '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 0x100875db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a48b20>, '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.9c2loKL8iY/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.OfDHTjqTqo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 07:48:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:48:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:48:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9c2loKL8iY/Render', 07:48:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:01 INFO - 'HOME': '/Users/cltbld', 07:48:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:01 INFO - 'LOGNAME': 'cltbld', 07:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:01 INFO - 'MOZ_NO_REMOTE': '1', 07:48:01 INFO - 'NO_EM_RESTART': '1', 07:48:01 INFO - 'PAGER': '/bin/cat', 07:48:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:01 INFO - 'PWD': '/builds/slave/test', 07:48:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:01 INFO - 'SHELL': '/bin/bash', 07:48:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OfDHTjqTqo/Listeners', 07:48:01 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 07:48:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:01 INFO - 'USER': 'cltbld', 07:48:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:01 INFO - 'XPC_FLAGS': '0x0', 07:48:01 INFO - 'XPC_SERVICE_NAME': '0', 07:48:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:48:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:48:04 INFO - Installing collected packages: mozsystemmonitor 07:48:04 INFO - Running setup.py install for mozsystemmonitor 07:48:04 INFO - Successfully installed mozsystemmonitor 07:48:04 INFO - Cleaning up... 07:48:04 INFO - Return code: 0 07:48:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:04 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 0x100bada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bb54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdaacbdec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a51d30>, '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 0x100875db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a48b20>, '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.9c2loKL8iY/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.OfDHTjqTqo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 07:48:04 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 07:48:04 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 07:48:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9c2loKL8iY/Render', 07:48:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:04 INFO - 'HOME': '/Users/cltbld', 07:48:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:04 INFO - 'LOGNAME': 'cltbld', 07:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:04 INFO - 'MOZ_NO_REMOTE': '1', 07:48:04 INFO - 'NO_EM_RESTART': '1', 07:48:04 INFO - 'PAGER': '/bin/cat', 07:48:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:04 INFO - 'PWD': '/builds/slave/test', 07:48:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:04 INFO - 'SHELL': '/bin/bash', 07:48:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OfDHTjqTqo/Listeners', 07:48:04 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 07:48:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:04 INFO - 'USER': 'cltbld', 07:48:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:04 INFO - 'XPC_FLAGS': '0x0', 07:48:04 INFO - 'XPC_SERVICE_NAME': '0', 07:48:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:04 INFO - Downloading/unpacking blobuploader==1.2.4 07:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:07 INFO - Downloading blobuploader-1.2.4.tar.gz 07:48:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:48:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:48: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 07:48: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 07:48: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 07:48: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 07:48: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 07:48: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 07:48:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:48:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:48: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 07:48: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 07:48: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 07:48: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 07:48: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 07:48: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 07:48:08 INFO - Downloading docopt-0.6.1.tar.gz 07:48:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:48:08 INFO - Installing collected packages: blobuploader, requests, docopt 07:48:08 INFO - Running setup.py install for blobuploader 07:48:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:48:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:48:08 INFO - Running setup.py install for requests 07:48:09 INFO - Running setup.py install for docopt 07:48:09 INFO - Successfully installed blobuploader requests docopt 07:48:09 INFO - Cleaning up... 07:48:09 INFO - Return code: 0 07:48:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:09 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 0x100bada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bb54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdaacbdec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a51d30>, '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 0x100875db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a48b20>, '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.9c2loKL8iY/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.OfDHTjqTqo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 07:48:09 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 07:48:09 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 07:48:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9c2loKL8iY/Render', 07:48:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:09 INFO - 'HOME': '/Users/cltbld', 07:48:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:09 INFO - 'LOGNAME': 'cltbld', 07:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:09 INFO - 'MOZ_NO_REMOTE': '1', 07:48:09 INFO - 'NO_EM_RESTART': '1', 07:48:09 INFO - 'PAGER': '/bin/cat', 07:48:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:09 INFO - 'PWD': '/builds/slave/test', 07:48:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:09 INFO - 'SHELL': '/bin/bash', 07:48:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OfDHTjqTqo/Listeners', 07:48:09 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 07:48:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:09 INFO - 'USER': 'cltbld', 07:48:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:09 INFO - 'XPC_FLAGS': '0x0', 07:48:09 INFO - 'XPC_SERVICE_NAME': '0', 07:48:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:48:09 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-g9YwMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:48:09 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-npFeN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:48:09 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-ds9BM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:48:09 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-m0v1K8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:48:10 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-my7sNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:48:10 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-h8gGMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:48:10 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-CLO9ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:48:10 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-qe21Ob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:48:10 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-s3khmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:48:10 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-GseMCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:48:10 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-WNtxge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:48:10 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-HHxBLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:48:10 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-8xpVe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:48:10 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-UBacSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:11 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-CEp1o7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:48:11 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-OzrB77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:48:11 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-EEUaYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:48:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:48:11 INFO - Running setup.py install for manifestparser 07:48:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:48:11 INFO - Running setup.py install for mozcrash 07:48:11 INFO - Running setup.py install for mozdebug 07:48:11 INFO - Running setup.py install for mozdevice 07:48:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:48:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:48:12 INFO - Running setup.py install for mozfile 07:48:12 INFO - Running setup.py install for mozhttpd 07:48:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:48:12 INFO - Running setup.py install for mozinfo 07:48:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:48:12 INFO - Running setup.py install for mozInstall 07:48:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:48:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:48:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:48:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:48:12 INFO - Running setup.py install for mozleak 07:48:12 INFO - Running setup.py install for mozlog 07:48:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:48:12 INFO - Running setup.py install for moznetwork 07:48:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:48:13 INFO - Running setup.py install for mozprocess 07:48:13 INFO - Running setup.py install for mozprofile 07:48:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:48:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:48:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:48:13 INFO - Running setup.py install for mozrunner 07:48:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:48:13 INFO - Running setup.py install for mozscreenshot 07:48:13 INFO - Running setup.py install for moztest 07:48:13 INFO - Running setup.py install for mozversion 07:48:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:48:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:48:13 INFO - Cleaning up... 07:48:13 INFO - Return code: 0 07:48:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:13 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 0x100bada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bb54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdaacbdec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a51d30>, '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 0x100875db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a48b20>, '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.9c2loKL8iY/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.OfDHTjqTqo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 07:48:13 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 07:48:13 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 07:48:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9c2loKL8iY/Render', 07:48:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:13 INFO - 'HOME': '/Users/cltbld', 07:48:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:13 INFO - 'LOGNAME': 'cltbld', 07:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:13 INFO - 'MOZ_NO_REMOTE': '1', 07:48:13 INFO - 'NO_EM_RESTART': '1', 07:48:13 INFO - 'PAGER': '/bin/cat', 07:48:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:13 INFO - 'PWD': '/builds/slave/test', 07:48:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:13 INFO - 'SHELL': '/bin/bash', 07:48:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OfDHTjqTqo/Listeners', 07:48:13 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 07:48:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:13 INFO - 'USER': 'cltbld', 07:48:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:13 INFO - 'XPC_FLAGS': '0x0', 07:48:13 INFO - 'XPC_SERVICE_NAME': '0', 07:48:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:48:14 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-9BjvVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:48:14 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)) 07:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:48:14 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-Iwp0R1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:48:14 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)) 07:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:48:14 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-S4Kmt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:48:14 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)) 07:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:48:14 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-TRNIaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:48:14 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)) 07:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:48:14 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-mTBhpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:48:14 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)) 07:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:48:14 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-GBkh7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:48:14 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)) 07:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:48:14 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-B8UXsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:48:14 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)) 07:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:48:15 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-JwOinN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:48:15 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)) 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:48:15 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-VSagFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:48:15 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)) 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:48:15 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-4VmJT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:48:15 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)) 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:48:15 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-HZ_kyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:48:15 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)) 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:48:15 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-9xxhlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:48:15 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)) 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:48:15 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-B01blo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:48:15 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)) 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:48:15 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-lrhzuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:48:15 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)) 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:15 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-bvmbor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:15 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)) 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:48:15 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-_pp048-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:48:15 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)) 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:48:15 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-r6jfmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:48:16 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)) 07:48:16 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)) 07:48:16 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)) 07:48:16 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)) 07:48:16 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)) 07:48:16 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)) 07:48:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:18 INFO - Downloading blessings-1.6.tar.gz 07:48:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:48:18 INFO - Installing collected packages: blessings 07:48:18 INFO - Running setup.py install for blessings 07:48:18 INFO - Successfully installed blessings 07:48:18 INFO - Cleaning up... 07:48:18 INFO - Return code: 0 07:48:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:48:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:48:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:48:19 INFO - Reading from file tmpfile_stdout 07:48:19 INFO - Current package versions: 07:48:19 INFO - blessings == 1.6 07:48:19 INFO - blobuploader == 1.2.4 07:48:19 INFO - docopt == 0.6.1 07:48:19 INFO - manifestparser == 1.1 07:48:19 INFO - mozInstall == 1.12 07:48:19 INFO - mozcrash == 0.17 07:48:19 INFO - mozdebug == 0.1 07:48:19 INFO - mozdevice == 0.48 07:48:19 INFO - mozfile == 1.2 07:48:19 INFO - mozhttpd == 0.7 07:48:19 INFO - mozinfo == 0.9 07:48:19 INFO - mozleak == 0.1 07:48:19 INFO - mozlog == 3.1 07:48:19 INFO - moznetwork == 0.27 07:48:19 INFO - mozprocess == 0.22 07:48:19 INFO - mozprofile == 0.28 07:48:19 INFO - mozrunner == 6.11 07:48:19 INFO - mozscreenshot == 0.1 07:48:19 INFO - mozsystemmonitor == 0.0 07:48:19 INFO - moztest == 0.7 07:48:19 INFO - mozversion == 1.4 07:48:19 INFO - psutil == 3.1.1 07:48:19 INFO - requests == 1.2.3 07:48:19 INFO - wsgiref == 0.1.2 07:48:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48:19 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')]} 07:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:19 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')]} 07:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:19 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 0x100bada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bb54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdaacbdec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a51d30>, '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 0x100875db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a48b20>, '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.9c2loKL8iY/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.OfDHTjqTqo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 07:48:19 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 07:48:19 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 07:48:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9c2loKL8iY/Render', 07:48:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:19 INFO - 'HOME': '/Users/cltbld', 07:48:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:19 INFO - 'LOGNAME': 'cltbld', 07:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:19 INFO - 'MOZ_NO_REMOTE': '1', 07:48:19 INFO - 'NO_EM_RESTART': '1', 07:48:19 INFO - 'PAGER': '/bin/cat', 07:48:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:19 INFO - 'PWD': '/builds/slave/test', 07:48:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:19 INFO - 'SHELL': '/bin/bash', 07:48:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OfDHTjqTqo/Listeners', 07:48:19 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 07:48:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:19 INFO - 'USER': 'cltbld', 07:48:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:19 INFO - 'XPC_FLAGS': '0x0', 07:48:19 INFO - 'XPC_SERVICE_NAME': '0', 07:48:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:19 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)) 07:48:19 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)) 07:48:19 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)) 07:48:19 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)) 07:48:19 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)) 07:48:19 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)) 07:48:19 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)) 07:48:19 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)) 07:48:19 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)) 07:48:19 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)) 07:48:19 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)) 07:48:19 INFO - Cleaning up... 07:48:19 INFO - Return code: 0 07:48:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:48:19 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')]} 07:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:19 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')]} 07:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:19 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 0x100bada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bb54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdaacbdec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a51d30>, '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 0x100875db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a48b20>, '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.9c2loKL8iY/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.OfDHTjqTqo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 07:48:19 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 07:48:19 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 07:48:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9c2loKL8iY/Render', 07:48:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:19 INFO - 'HOME': '/Users/cltbld', 07:48:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:19 INFO - 'LOGNAME': 'cltbld', 07:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:19 INFO - 'MOZ_NO_REMOTE': '1', 07:48:19 INFO - 'NO_EM_RESTART': '1', 07:48:19 INFO - 'PAGER': '/bin/cat', 07:48:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:19 INFO - 'PWD': '/builds/slave/test', 07:48:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:19 INFO - 'SHELL': '/bin/bash', 07:48:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OfDHTjqTqo/Listeners', 07:48:19 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 07:48:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:19 INFO - 'USER': 'cltbld', 07:48:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:19 INFO - 'XPC_FLAGS': '0x0', 07:48:19 INFO - 'XPC_SERVICE_NAME': '0', 07:48:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:19 INFO - Downloading/unpacking jsonschema 07:48:19 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 07:48:19 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 07:48:19 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 07:48:19 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 07:48:19 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 07:48:19 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 07:48:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:48:22 INFO - Downloading/unpacking functools32 (from jsonschema) 07:48:22 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 07:48:22 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 07:48:22 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 07:48:22 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 07:48:22 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 07:48:22 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 07:48:22 INFO - Downloading functools32-3.2.3-2.tar.gz 07:48:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:48:22 INFO - warning: no files found matching '*.txt' 07:48:22 INFO - no previously-included directories found matching 'build' 07:48:22 INFO - no previously-included directories found matching 'dist' 07:48:22 INFO - no previously-included directories found matching '.git*' 07:48:22 INFO - Installing collected packages: jsonschema, functools32 07:48:22 INFO - Running setup.py install for functools32 07:48:22 INFO - warning: no files found matching '*.txt' 07:48:22 INFO - no previously-included directories found matching 'build' 07:48:22 INFO - no previously-included directories found matching 'dist' 07:48:22 INFO - no previously-included directories found matching '.git*' 07:48:22 INFO - Successfully installed jsonschema functools32 07:48:22 INFO - Cleaning up... 07:48:22 INFO - Return code: 0 07:48:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100bada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bb54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdaacbdec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a51d30>, '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 0x100875db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a48b20>, '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.9c2loKL8iY/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.OfDHTjqTqo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 07:48:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:48:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9c2loKL8iY/Render', 07:48:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:22 INFO - 'HOME': '/Users/cltbld', 07:48:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:22 INFO - 'LOGNAME': 'cltbld', 07:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:22 INFO - 'MOZ_NO_REMOTE': '1', 07:48:22 INFO - 'NO_EM_RESTART': '1', 07:48:22 INFO - 'PAGER': '/bin/cat', 07:48:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:22 INFO - 'PWD': '/builds/slave/test', 07:48:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:22 INFO - 'SHELL': '/bin/bash', 07:48:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OfDHTjqTqo/Listeners', 07:48:22 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 07:48:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:22 INFO - 'USER': 'cltbld', 07:48:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:22 INFO - 'XPC_FLAGS': '0x0', 07:48:22 INFO - 'XPC_SERVICE_NAME': '0', 07:48:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:23 INFO - Downloading/unpacking flake8 07:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:48:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:48:25 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 07:48:25 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 07:48:25 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 07:48:25 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 07:48:25 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 07:48:25 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 07:48:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:48:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:48:25 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 07:48:25 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 07:48:25 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 07:48:25 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 07:48:25 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 07:48:25 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 07:48:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:48: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 07:48: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 07:48: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 07:48: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 07:48: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 07:48: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 07:48:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:48:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:48:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:48:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:48:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:48:26 INFO - no previously-included directories found matching 'docs/_build' 07:48:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:48:26 INFO - Running setup.py install for pep8 07:48:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:48:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:48:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:48:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:48:26 INFO - no previously-included directories found matching 'docs/_build' 07:48:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:48:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:48:26 INFO - Cleaning up... 07:48:26 INFO - Return code: 0 07:48:26 INFO - Running post-action listener: _resource_record_post_action 07:48:26 INFO - Running post-action listener: _start_resource_monitoring 07:48:26 INFO - Starting resource monitoring. 07:48:26 INFO - ##### 07:48:26 INFO - ##### Running install step. 07:48:26 INFO - ##### 07:48:26 INFO - Running pre-action listener: _resource_record_pre_action 07:48:26 INFO - Running main action method: install 07:48:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:48:27 INFO - Reading from file tmpfile_stdout 07:48:27 INFO - Detecting whether we're running mozinstall >=1.0... 07:48:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:48:27 INFO - Reading from file tmpfile_stdout 07:48:27 INFO - Output received: 07:48:27 INFO - Usage: mozinstall [options] installer 07:48:27 INFO - Options: 07:48:27 INFO - -h, --help show this help message and exit 07:48:27 INFO - -d DEST, --destination=DEST 07:48:27 INFO - Directory to install application into. [default: 07:48:27 INFO - "/builds/slave/test"] 07:48:27 INFO - --app=APP Application being installed. [default: firefox] 07:48:27 INFO - mkdir: /builds/slave/test/build/application 07:48:27 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'] 07:48:27 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 07:49:01 INFO - Reading from file tmpfile_stdout 07:49:01 INFO - Output received: 07:49:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:49:01 INFO - Running post-action listener: _resource_record_post_action 07:49:01 INFO - ##### 07:49:01 INFO - ##### Running run-tests step. 07:49:01 INFO - ##### 07:49:01 INFO - Running pre-action listener: _resource_record_pre_action 07:49:01 INFO - Running main action method: run_tests 07:49:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:49:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:49:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:49:01 INFO - 2016-03-16 07:49:01.130 screenresolution[6208:100781] starting screenresolution argv=screenresolution get 07:49:01 INFO - 2016-03-16 07:49:01.133 screenresolution[6208:100781] Display 0: 1600x1200x32@60 07:49:01 INFO - 2016-03-16 07:49:01.139 screenresolution[6209:100783] starting screenresolution argv=screenresolution list 07:49:01 INFO - Available Modes on Display 0 07:49:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:49:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:49:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:49:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:49:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:49:01 INFO - Intel Iris: 07:49:01 INFO - Chipset Model: Intel Iris 07:49:01 INFO - Type: GPU 07:49:01 INFO - Bus: Built-In 07:49:01 INFO - VRAM (Dynamic, Max): 1536 MB 07:49:01 INFO - Vendor: Intel (0x8086) 07:49:01 INFO - Device ID: 0x0a2e 07:49:01 INFO - Revision ID: 0x0009 07:49:01 INFO - Displays: 07:49:01 INFO - Display: 07:49:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:49:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:49:01 INFO - Display Serial Number: 1600x1200 60 07:49:01 INFO - Main Display: Yes 07:49:01 INFO - Mirror: Off 07:49:01 INFO - Online: Yes 07:49:01 INFO - Rotation: Supported 07:49:01 INFO - Return code: 0 07:49:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:49:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:49:01 INFO - Python 2.7.3 07:49:01 INFO - Return code: 0 07:49:01 INFO - grabbing minidump binary from tooltool 07:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:01 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 0x100a51d30>, '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 0x100875db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a48b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:49:01 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 07:49:01 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 07:49:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:49:01 INFO - Return code: 0 07:49:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:49:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:49:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:49:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:49:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:49:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:49:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:49:02 INFO - Return code: 0 07:49:02 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/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0186', '--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 07:49:02 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/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0186 --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 07:49:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9c2loKL8iY/Render', 07:49:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:49:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:49:02 INFO - 'HOME': '/Users/cltbld', 07:49:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:49:02 INFO - 'LOGNAME': 'cltbld', 07:49:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:49:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:02 INFO - 'MOZ_NO_REMOTE': '1', 07:49:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:49:02 INFO - 'NO_EM_RESTART': '1', 07:49:02 INFO - 'PAGER': '/bin/cat', 07:49:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:02 INFO - 'PWD': '/builds/slave/test', 07:49:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:49:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:49:02 INFO - 'SHELL': '/bin/bash', 07:49:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OfDHTjqTqo/Listeners', 07:49:02 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 07:49:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:49:02 INFO - 'USER': 'cltbld', 07:49:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:49:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:02 INFO - 'XPC_FLAGS': '0x0', 07:49:02 INFO - 'XPC_SERVICE_NAME': '0', 07:49:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:49:02 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/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0186', '--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 07:49:02 INFO - mozversion application_buildid: 20160316064345 07:49:02 INFO - mozversion application_changeset: 360e21e14e09be0c9aa607a0d7d256b0f5a2bc5b 07:49:02 INFO - mozversion application_display_name: Nightly 07:49:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:49:02 INFO - mozversion application_name: Firefox 07:49:02 INFO - mozversion application_remotingname: firefox 07:49:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:49:02 INFO - mozversion application_vendor: Mozilla 07:49:02 INFO - mozversion application_version: 48.0a1 07:49:02 INFO - mozversion platform_buildid: 20160316064345 07:49:02 INFO - mozversion platform_changeset: 360e21e14e09be0c9aa607a0d7d256b0f5a2bc5b 07:49:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:49:02 INFO - mozversion platform_version: 48.0a1 07:49:02 INFO - using testdate: 1458139742 07:49:02 INFO - actual date: 1458139742 07:49:02 INFO - starting webserver on 'localhost:56766' 07:49:02 INFO - SUITE-START | Running 2 tests 07:49:02 INFO - TEST-START | dromaeo_css 07:49:02 INFO - operating with platform_type : mac_ 07:49:02 INFO - Initialising browser for dromaeo_css test... 07:49:02 INFO - TEST-INFO | started process 6227 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmpnjU1XT/profile http://localhost:56766/getInfo.html) 07:49:05 INFO - PROCESS | 6227 | __metrics Screen width/height:1600/1200 07:49:05 INFO - PROCESS | 6227 | colorDepth:24 07:49:05 INFO - PROCESS | 6227 | Browser inner width/height: 1024/689 07:49:05 INFO - PROCESS | 6227 | __metrics 07:49:05 INFO - PROCESS | 6227 | 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" 07:49:05 ERROR - PROCESS | 6227 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:49:05 INFO - TEST-INFO | 6227: exit 0 07:49:05 INFO - Browser initialized. 07:49:05 INFO - Running cycle 1/1 for dromaeo_css test... 07:49:05 INFO - TEST-INFO | started process 6231 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmpnjU1XT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:49:17 INFO - PROCESS | 6231 | RSS: Main: 243466240 07:49:17 INFO - PROCESS | 6231 | 07:50:09 INFO - PROCESS | 6231 | 1458139809114 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] 07:52:18 INFO - PROCESS | 6231 | Cycle 1(1): loaded http://localhost:56766/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56766/tests/dromaeo/cssquery-ext.html) 07:52:20 INFO - PROCESS | 6231 | RSS: Main: 328085504 07:52:20 INFO - PROCESS | 6231 | 07:55:22 INFO - PROCESS | 6231 | Cycle 1(1): loaded http://localhost:56766/tests/dromaeo/cssquery-ext.html (next: http://localhost:56766/tests/dromaeo/cssquery-jquery.html) 07:55:23 INFO - PROCESS | 6231 | RSS: Main: 373174272 07:55:23 INFO - PROCESS | 6231 | 07:58:25 INFO - PROCESS | 6231 | Cycle 1(1): loaded http://localhost:56766/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56766/tests/dromaeo/cssquery-mootools.html) 07:58:26 INFO - PROCESS | 6231 | RSS: Main: 375697408 07:58:26 INFO - PROCESS | 6231 | 08:01:28 INFO - PROCESS | 6231 | Cycle 1(1): loaded http://localhost:56766/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56766/tests/dromaeo/cssquery-prototype.html) 08:01:28 INFO - PROCESS | 6231 | RSS: Main: 330338304 08:01:28 INFO - PROCESS | 6231 | 08:04:31 INFO - PROCESS | 6231 | Cycle 1(1): loaded http://localhost:56766/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56766/tests/dromaeo/cssquery-yui.html) 08:04:32 INFO - PROCESS | 6231 | RSS: Main: 335794176 08:04:32 INFO - PROCESS | 6231 | 08:07:34 INFO - PROCESS | 6231 | Cycle 1(1): loaded http://localhost:56766/tests/dromaeo/cssquery-yui.html (next: http://localhost:56766/tests/dromaeo/cssquery-dojo.html) 08:07:35 INFO - PROCESS | 6231 | RSS: Main: 395386880 08:07:35 INFO - PROCESS | 6231 | 08:07:35 INFO - PROCESS | 6231 | __start_tp_report 08:07:35 INFO - PROCESS | 6231 | _x_x_mozilla_page_load 08:07:35 INFO - PROCESS | 6231 | _x_x_mozilla_page_load_details 08:07:35 INFO - PROCESS | 6231 | |i|pagename|runs| 08:07:35 INFO - PROCESS | 6231 | |0;dojo.html;3361.428557145285;3417.7607567470272;3420.521127042213;3443.3285509325683;3490.3891818931697;5535.501804837564;5656.575756818244;5659.745311460983;5715.457031581998;5717.971410142949;5623.80316688916;5690.829275121742;5694.060480020791;5712.428757124286;5718.857028574288;5119.38567371915;5137.743112844343;5168.250603662466;5202.869928251786;5243.9213411798855;5239.449857764937;5240.109181439146;5251.054810134175;5252.579793616521;5255.421903590602;5144;5186.0665080285535;5211.400688920766;5216;5238.580913526908;5256.658317209388;5280.313559237313;5289.285946397225;5292.153255479105;5344.465553444663;5085.847424577269;5091.516305950929;5111.284420181178;5193.714345710984;5226.111561034633;5602.0196465618355;5611.663300202001;5622.9597524457695;5632.859178520529;5668.036433806263;6108.419700128481;6117.877642447126;6125.203723515959;6136.386361363872;6142.201513803222;6038.245219347582;6080.817575472743;6113.663748493831;6121.66330851803;6139.87720245597;5836.7957121501395;5868.706564671792;5871.500922421642;5887.4406931341455;5889.734961926681;6204.720787564571;6226.439620434183;6226.533010024266;6230;6235.719392627343;5970.910436343458;6044.214252147192;6108.5418593605655;6109.040306147788;6114.144019837227;6071.757129714851;6129.417705317987;6147.877042459126;6153.169322141453;6161.8459538511;6098.939010609837;6137.294211165773;6143.723532441051;6157.168782214344;6171.074338849119;6073;6095.891769653442;6122.825106970096;6127.372786728296;6152.8769424611255;4848.345473361122;4878.512148785093;4896.632752543574;4910.8281210157475;4917.1149193145575;4352.064306174188;4352.347147927773;4366.6506679465565;4369.69412141147;4411.272140096912;5579.776808927679;5672.8865422691315;5684.573656975661;5692.686902220417;5777.711114444261;6120.69094295093;6121.910283036266;6122.916604401382;6124.564025909317;6134.957077261001;5752.252207213036;5762.366139724627;5765.625234359753;5766.279215098113;5770.740316685759;4980.12847751642;5030.396352437658;5190.766415511311;5339.466053394707;5373.2208829719475;6262.812115636538;6280.905786413116;6282.026285925689;6282.308946015934;6286.277078136073;5542.944570554243;5924.407559244213;6104;6111.816645500642;6140.293866205265;6158.692065396802;6217.160683307877;6243.594166379171;6296.0555916612875;6320.1467801848;6078.45293923549;6098.573099883143;6129.570930034854;6145.8156255312415;6154.446099851035;6100.481459075851;6120.724567394389;6126.6017708848785;6127.387261273837;6136.846578835565;6036.728347224298;6068.787592434243;6083.6653984029535;6105.126180223362;6121.602095863755;5910.468057874812;6057.394260574084;6083.209182806207;6101.2068431105445;6101.359357267423;5789.131630255495;5886.470217680429;5981.641101533922;5984.850378740566;5986.700664966647;4737.763111844325;5936.673482958478;6026.668533230714;6047.697615119138;6080.574359794949;5881.852953676193;5888.440598143169;5916.112583112567;5940.940590594038;5957.76168953237 08:07:35 INFO - PROCESS | 6231 | |1;ext.html;478.6410192355733;520.9739513024348;591.2668291318766;635.698043429371;637.6779726238251;30415.543766843515;37860.62139378605;38021.42967855481;38100.80949595255;38191.61808381915;41924;42541.57458425415;42548.93627659302;42580.36129458053;42613.57386426135;9580.233581313512;9769.364991275545;9796;9805.803883922317;9811.362261453018;9508.096730810563;9690.127888490035;9695;9696.418214907128;9700.029997000314;9671.468069256189;9864.914859365465;9874.012598740104;9883.50582470877;9907.108360247576;9786.021397860228;9786.461744604045;9845.064718851698;9849.950750246238;9872.45701486418;9688.951555242249;9820.607175713034;9824.1649459796;9830.459324737136;9842.409455432697;40733.77798666045;41107.58892411068;41118.79440602808;41166.588334116874;41250.38124428136;3263.592050993626;3364.52896594477;3378.7972721636534;3419.008487538611;3627.9274414511824;29216.415671686445;29364.853175733984;29436.70563294361;29969;30214;2790.525610646195;2806.7193280671972;2857.014330056127;2873.037532426619;2881.236472334833;460335;463053.6847315776;465599;468148.2518461517;469425;44285.89285267894;44907.55092449034;65001.67499162474;65461;65917;44623.330650040276;44725.55274447279;44872.3269150963;44879;45003.77498112489;15522.301496432689;15634.452794152377;15646.843531564538;15660.530184094496;15673.608159796097;12584.937075314565;12677.809832852514;12684.175528590613;12692.17500862441;12706.555270565486;14535.982481226212;14826.777598336033;14829.703405932038;14859.257037148316;14984.47554335593;6297.748090076346;6404.23149222087;6496.6426846522945;6502.479801615859;6511.218653761579;965.8164948659733;993.8459538771502;998.9200863930868;1034.04350975349;1177.2419753822182;26476.338091547866;28294.717052829208;29043.56434653482;29152.41695166085;29921.40157196844;944.607987685103;1070.7483741320784;1074.946252687378;1120.40058568667;1159.6231224851788;11631.302121872546;14722.484713034992;14821.851781482263;15170.620734481505;15205.695886082216;445059;509430;521651;522367;524501;59149;59174.40825591775;59292.33184506708;59365;60315.09527357093;1345.1727187779445;1467.156385078584;1480.7334679757746;1492.388120870438;1497.677999230149;28215.71784282213;28900.949123980536;28923.566146507397;28927;29615;47343.52656473391;47789;48348.03303933831;48356.274655880894;48404.7579762113;316334;319301;319368.8063119432;319423;319846;27938.441231175668;28189.154325370273;31256.374872502878;33465.83267083649;33866.81466148673;41110.9722256946;41468.37797432981;41597.37603935883;41850.581494185884;42259.154816902876;33701.98894033183;34922.650773492955;35686;36301.45547816838;37073.258534828616;35602.46596301006;35831.28337433185;36136;36422.27155456823;36423.453648194765;35257;35748;35991.28017439689;36292.45561316529;36843.447348290334;27931.72068279291;30510.237244069074;31179.872816198862;31777.046688599377;32132.97227749465;21838.23566175176;23424.297271081894;23940.372670807454;24117.397065073514;24199.395015124763 08:07:35 INFO - PROCESS | 6231 | |2;jquery.html;359.1685248649378;361.95113659655937;362.55949021938346;365.4992660055724;374.6721618583739;19046.238150473982;19221.711674324877;20380.796192038077;20397.694034589495;20400.89799551;14678.486252981147;19425.708614370797;19757.703634445494;19764.703529447033;19796.30712925048;5593.776248950037;5893.764249430018;5920.674362910038;5925.822225333225;5925.851853703671;4215.915681686364;4416.359627853959;5833.679147646878;6211.503079753609;6494.740210391578;6397.744090236385;6424.2290925089055;6424.839379015515;6430.967845160791;6431.903521447182;6113.724882380304;6381.553291269613;6389.904151437732;6420.26166990795;6427.485801135898;3714.275716235335;5276.736163191825;5486.890262194734;5496.670199787985;5511;23948.161814336414;24196.15313464038;24421.778911054374;24725.5054898901;24775.752242477523;2105.631514484974;2164.8385586339414;2178.6840908068243;2308.8037516810923;2819.830810151377;8929.642814287421;9269.397489163182;9441.952790236073;14496;14978.47575334858;1452.8256609206858;1732.5322163016042;1891.5743957609566;1898.411492437349;1901.8003109673423;94157.52921235419;95284.52357738167;99336.99999999927;99810;102188.48905755498;11200.991910727911;11263.943680281545;11283.830742538705;11290;11405.486753096131;13375.264360460074;13487.527936522174;13538.93230533841;13568.050236483352;13573.796393054112;8317.043539992857;8478.279346255515;8493.872591911126;8574.142585741376;8576.957115214384;8619.439736417113;8630.43902146371;8657.39398242117;8736.25741811953;8801.911980880237;4243.554426785205;4301.569843015736;4385.7149285296355;4424.579664931826;4475.328700694857;1486.843881392438;1745.3978377459755;1804.5037614656076;1830.5972686009056;1856.2853301478758;872.2803686958284;941.5527624378502;943.5376665433888;993.2203220471895;1086.3319058778952;15179.848201517843;17981;19865.30471433522;19877.701834472493;20302.593948120953;957.9185769209695;962.2061799015839;980.1570649241646;1009.4952523738131;1036.0261354326908;8033.799155021171;10497.212709046851;10526.842097368546;10673.519691613896;10715.46422678863;609375;614894;620642;638254;640173;109124.90875091306;109845;110092.4495377518;112130.43934780273;113358;1009.152312057875;1024.1653052761976;1028.4395004722594;1043.1811028342865;1045.5660900726266;17265.482035538953;17288.65422691564;17539.123043848012;17635.911820440815;17787.911060444614;46143.307850382946;47360.895865620434;47758.522414775405;48728.2690759646;51280;62846.74306513936;62926.68536657288;63243.367566323745;63276.68361658162;67016;7265.673044713107;7412.777616671508;7431.628418579157;7509.361704254981;7691.269329413697;9832.9016709832;10132.986701330103;11504.769904602028;11948.940255298668;12418.254904705747;10281.383117013003;10509.31689440184;10515.894841051491;10657.094146997591;10763.3541987481;10233.9488302558;10358.948205258925;10404.791904162026;10515.369077855354;10722.624708135178;10415.63545275942;10478.348539599525;10945.124390048617;10998.725031874266;11119.332840029301;7329.303716146957;7410.258974102547;7455.254474552718;7501.812454688458;7621.885671714817;8232.50604963704;10550.683479495627;10591.8940810594;10810.405427701236;10820.945895270474 08:07:35 INFO - PROCESS | 6231 | |3;mootools.html;1445.754221782297;1566.7179907616628;1570.0893481780568;1834;1986.2750096214877;7935.801604959879;8580.39937204396;8741.737747867559;8760.036395996436;8764.25503832175;8435.367347448935;8696.434731742433;8722.127787221274;8727.738167854974;8746.86879696805;2135.2419890938727;2395.125779090628;2438.3050830513353;2477.331120597438;2479.3181874984434;2112.947176320589;2439.0487709793197;2447.68180136582;2453.9754602454013;2454.47228845799;2399.0283935006264;2425.8301918865686;2435.926922192328;2457.6559281700575;2463.470353873917;2117.6400011998;2148.398448434441;2451.8528888266674;2461.113998960373;2464.617984212441;2426.720927093389;2427.041318679112;2441.060191826142;2445.2053082748;2445.2297526279344;8835.116488351114;8891.377603567753;8902.643894244287;8911.331650126267;8912.287017038621;5364.222187782789;5481.835544933659;5486.1222204447495;5486.847761969991;5493.285872836545;3541.203229273393;3612.9096772580633;3656.8720094796554;3660.5607327120915;3693.649103335179;883.5802993578063;909.2135302962955;1099.483242875847;1602.3750737212497;1651.9091449970247;11445.08439324852;11477.991351513452;11526.366049867254;11535.59625413115;11590.898864607849;4467.888302792391;4613.0773845230415;4673.345731597579;4677.298405239241;4683.976580117078;9226.40028398152;9264.166225039779;9274.21169200612;9274.536273186313;9275.72172834816;5315.893682126413;5316.787328506894;5328.387235467971;5351.983123206578;5364.14173732201;4352.303631418958;4423;4424.247877860707;4473.619742321874;4981.576565991859;3726.7391282610497;3728.7203459740626;3805.562360328542;3835.6931445484292;3837.9232415351535;1193.3913704011018;1204.7108693913397;1205.5057426455112;1213.854337479508;1215.7629262293767;1318.3013003108367;1322.966925826862;1361.5166615851429;1362.7887677410017;1365.6995460998564;8199;8266.214709602578;8458.788530286793;8462.87305690415;8472.576371181416;1041.6822869024868;1151.0848875144281;1155.3356819828632;1164.796160671879;1188.0554958807768;6265.8120256392385;6318.526110541636;6326.810195694136;6339.334369891188;6362.236531616236;10418.479076046167;10862.239643225057;10889.455527223607;10958.28771129874;11001.834972475419;10451.320664156805;10724.14206863449;10768.300060496043;10830.837537436944;10840.78318433627;8364.03813561436;8513;8532.8720069199;8604.48373097616;8608.225259726654;7974.282314591715;8046.195380461907;8080.838383232185;8139.186081391814;8185.345172386075;9532;9605.903940960501;9650.7587310315;9681.564329605326;9904.702858914245;9920.355176913477;9992.65099211597;10025.598976040877;10093.89906100959;10253.384796912209;7098.929010709827;7124.715011399486;7156.606386648784;7181.174164971095;7220.530665506725;8354.12281710436;8382.580870956306;8407.663693452438;8436.409451338348;8475.02537208229;7453.366463850633;7538.246175382418;7631.1605723371495;7736.2650548197835;7788.727394541163;7169.318914703095;7297.270272972661;7345.6694448751;7349.448791340564;7549.09410870677;7644.350230230492;7720.922790772245;7727.729529466442;7732.342750866014;7737.419693523121;5973.701314934323;6040.305364882919;6931.930680693128;6966.512344135862;7041.471889608198;6371.362863713592;6587.9670601646685;7026.402755765817;7097.7160913562875;7101.11236095488 08:07:35 INFO - PROCESS | 6231 | |4;prototype.html;318.9394015137124;320.72417720760143;325.45161403035877;328.40722495894914;331.1935437210394;6420.614763114217;6536.7385304587815;6546.214454265483;6570.770023049195;6574.769883054094;6500.869982600357;6624.933750662492;6629.73481060757;6633.402993730563;6644;4657.790399432034;4733.242681171013;4743.715377077387;4834.830780922668;4929.507049295069;4830.951690483085;4851.369321988137;4867.9269810952865;4896.265560165968;4916.115099282128;4784.186688263004;4806.975965120169;4834.105690447261;4837.951620483803;4839.5644392004715;3720.7209459290525;4681.321208424776;4790.664653474259;4800.207965685658;4810.591099756525;4072.328065869128;4074.470318858559;4078.796060197008;4089.5501494835544;4096.836126554934;5996.100584912255;6352.396522330371;6387.4251317381195;6391.424771770517;6401.039844023388;5667.064934285879;5669.489745922846;5674.801381951653;5675.262215911905;5681.460261275172;6787.864242715118;6994.0907682001525;7005;7017.508774385795;7018.613976231305;4549.954500455019;4643.8374656886845;4645.488996210414;4657.254839225741;4660.254359302496;7423.257674232587;7426.2945020223;7433.553986760758;7441.7023319067175;7449.441291903129;4692.718436893797;4693.436787585443;4699.436067671902;4703.2004559225015;4704.388429504143;4442.6890117691455;4528.456585209796;4749.35883655702;4755.762211889391;4758.666893317504;5630.296212973379;5645.858853528694;5646.491815736604;5654.434556544395;5655.830325090254;6821.590704557742;6956.617386043817;7069.399101076363;7070.5404148731195;7075.2217256101785;1510.6298956755445;1651.0506458786247;1659.1952902842113;1663.8336166383508;1664.2926756128838;1013.9188864890939;1047.8952104789612;1082.4479515447022;1092.847001419802;1113.8805500471974;6476.902846457307;6601.2738598754095;6616.768413105518;6696.631685257357;6724.49566282521;7349.154847192534;7361.521501102411;7363.447741419308;7371.631418429164;7378.594177320191;6678.933210667831;6683.398494135551;6687.598744075273;6699.76550820719;6708.765193218214;3760.811959402019;3849.6920246380223;3905.3556163233316;3912.8434862605177;3913.9217215655526;7209.639518024078;7709.4603377763015;7731.613419329011;7735.187805280477;7737;6761.661916904135;6862.348076932683;7569.507981981264;7575.962120189364;7576.7348142814735;7676.385889128856;7697.615119244016;7699.692012319557;7710.498817576839;7715.189905059888;7118.822029449305;7344.22885597026;7368.926310737039;7375.963120184365;7380.520266182681;5967.76128954837;7170.247124052108;7240.022596949344;7244.601546914971;7253.057102576631;7672.194419586086;7676.117246516722;7680.577568233801;7687.9231207689445;7710.11333696632;4693.741844198602;4702.106599746037;4708.058388322418;4710.340552322609;4712.670113092051;6023.849403764941;7296.233895441114;7312.378447831994;7315.743948961761;7320.450966177452;7009.614471204132;7014.193367762773;7060.6116663584;7064.152301723826;7064.32888875556;7056;7065.6113913735235;7076.292370763088;7079.539829911039;7080.858382832417;6909.481788865754;6914;6920.100386949664;6925.965370173117;6942.166939967236;6830.624315662686;7024.192217894803;7038.788836334918;7075.044868942627;7086.539374940612;6557.901631475627;6718.966405167943;6797.422219111431;6816.318368163144;6923.5499692519825 08:07:35 INFO - PROCESS | 6231 | |5;yui.html;656.8275628004013;698.9860202795943;742.7447613533128;775.573434610964;775.7905365551305;14540.127592344466;15163.393464261417;15173.317200725965;15174.393024279043;15177.848221517796;13897.096688715226;13969.650758731037;13982.021258511908;13984.65038374041;13985.93007034966;920.4845286639487;946.8721722567434;969.2633598465181;970.7184916374243;973.8101070291297;763.4121726270769;772.3666593393419;960.8558716192592;962.7916964209907;964.3490643815396;971.6744890461704;991.3506653142204;991.3754334769085;993.7565296502331;995.0845222395413;978.9755256118583;981.293468702533;982.1700662939804;983.1790454970109;985.9457729824857;594.1177351632822;739.9260073992612;740.8925705772687;748.2891253309377;748.745426554974;15194.316255768517;15214;15214.46749363778;15256.847431525764;15259.771103433457;12137.393130343537;12187.085968552305;12205.572804951873;12288.938555307255;12430.254184748945;9877.160441362494;9990.800183996353;10001.549930253155;10014.9499252504;10593.364398136137;3435.2957643682985;3435.9484607730906;3574.3744844652083;3632.836522356474;3681.44778283257;65959;85531;86192.55229790739;86202.56898715466;86432;9125.17873391398;9311.348205625676;9379.01520340368;9432.528373581294;9587.376820506644;20907.8954605226;20923.895380523;20932.37202883916;20933.89533052325;20949.266775662778;6951.16586009682;7026.074875331808;7066.611336376549;7078.433725302067;7181.605011724405;3854.69162467002;3939.1727737175515;3952.7825969571372;3961.3265744823448;4080.8571699990953;3284.556584861061;3381.968499607594;3502.2820321833965;3594.5866225383893;3601.675849173587;642.0337392224765;642.7043559962469;653.0563335979464;653.2030922274818;653.2030922274912;493.6963767283167;567.5289509707015;574.1215939612316;602.1269159718425;615.3723202333595;8127.674893004214;8192.098869124391;8284.958575207085;8290.751277461686;8301.335893128535;589.8613825750945;595.220261457492;607.520059153264;611.4344231585854;629.3706293706293;3762.6049264827348;3781.5084039074745;3835.137094153849;3900.4539364488996;3998.9200215995515;73515;74509.25490745132;74613.25386746171;94533;95148.52425737827;70080.59838803195;70349;70671.2932870675;73520;73735.63132184412;66699.66303706588;67546;67739.3226067733;68191;68463.65768171127;8389.790255243424;8422.473258022692;8457.450265732708;8493.108223636676;8559.229669329541;48253.5174648249;48433.75783121203;48524.514754853415;49295.507044929094;50010.749946250035;61934;63648;63990.68004659947;64464;64715.67642161759;10786.029257366874;11053.392063436588;11126.666200014013;11170.441477926233;11538.82691759641;11897.286162830258;12064.215825971283;12265.896069353801;12378.381080946097;12411.62765117048;10965.067969222706;11075.446227688744;11319.886801131883;11355.261907975955;11532.769344613229;11289.661310160709;11353.48909299067;11511.769764604493;11757;11843.23019003762;11124.944375278072;11241.269317494336;11363.602273920373;11458.026067784333;11681.88318116808;9360.765980850261;9461.451134258865;9563.282753793354;9909.009099090033;10072.043155900177;8424.809818642338;8679.783005424915;9420.670276540288;9614.855777163488;9660.806783864144 08:07:35 INFO - PROCESS | 6231 | __end_tp_report 08:07:35 INFO - PROCESS | 6231 | __start_cc_report 08:07:35 INFO - PROCESS | 6231 | _x_x_mozilla_cycle_collect,1223 08:07:35 INFO - PROCESS | 6231 | __end_cc_report 08:07:35 INFO - PROCESS | 6231 | __startTimestamp1458140855248__endTimestamp 08:07:35 INFO - PROCESS | 6231 | 08:07:35 INFO - PROCESS | 6231 | ------- Summary: start ------- 08:07:35 INFO - PROCESS | 6231 | Number of tests: 6 08:07:35 INFO - PROCESS | 6231 | 08:07:35 INFO - PROCESS | 6231 | [#0] dojo.html Cycles:165 Average:5688.61 Median:5916.11 stddev:615.13 (10.4%) stddev-sans-first:589.31 08:07:35 INFO - PROCESS | 6231 | Values: 3361.4 3417.8 3420.5 3443.3 3490.4 5535.5 5656.6 5659.7 5715.5 5718.0 5623.8 5690.8 5694.1 5712.4 5718.9 5119.4 5137.7 5168.3 5202.9 5243.9 5239.4 5240.1 5251.1 5252.6 5255.4 5144.0 5186.1 5211.4 5216.0 5238.6 5256.7 5280.3 5289.3 5292.2 5344.5 5085.8 5091.5 5111.3 5193.7 5226.1 5602.0 5611.7 5623.0 5632.9 5668.0 6108.4 6117.9 6125.2 6136.4 6142.2 6038.2 6080.8 6113.7 6121.7 6139.9 5836.8 5868.7 5871.5 5887.4 5889.7 6204.7 6226.4 6226.5 6230.0 6235.7 5970.9 6044.2 6108.5 6109.0 6114.1 6071.8 6129.4 6147.9 6153.2 6161.8 6098.9 6137.3 6143.7 6157.2 6171.1 6073.0 6095.9 6122.8 6127.4 6152.9 4848.3 4878.5 4896.6 4910.8 4917.1 4352.1 4352.3 4366.7 4369.7 4411.3 5579.8 5672.9 5684.6 5692.7 5777.7 6120.7 6121.9 6122.9 6124.6 6135.0 5752.3 5762.4 5765.6 5766.3 5770.7 4980.1 5030.4 5190.8 5339.5 5373.2 6262.8 6280.9 6282.0 6282.3 6286.3 5542.9 5924.4 6104.0 6111.8 6140.3 6158.7 6217.2 6243.6 6296.1 6320.1 6078.5 6098.6 6129.6 6145.8 6154.4 6100.5 6120.7 6126.6 6127.4 6136.8 6036.7 6068.8 6083.7 6105.1 6121.6 5910.5 6057.4 6083.2 6101.2 6101.4 5789.1 5886.5 5981.6 5984.9 5986.7 4737.8 5936.7 6026.7 6047.7 6080.6 5881.9 5888.4 5916.1 5940.9 5957.8 08:07:35 INFO - PROCESS | 6231 | 08:07:35 INFO - PROCESS | 6231 | [#1] ext.html Cycles:180 Average:57304.58 Median:36958.35 stddev:116217.98 (314.5%) stddev-sans-first:116465.69 08:07:35 INFO - PROCESS | 6231 | Values: 478.6 521.0 591.3 635.7 637.7 30415.5 37860.6 38021.4 38100.8 38191.6 41924.0 42541.6 42548.9 42580.4 42613.6 9580.2 9769.4 9796.0 9805.8 9811.4 9508.1 9690.1 9695.0 9696.4 9700.0 9671.5 9864.9 9874.0 9883.5 9907.1 9786.0 9786.5 9845.1 9850.0 9872.5 9689.0 9820.6 9824.2 9830.5 9842.4 40733.8 41107.6 41118.8 41166.6 41250.4 3263.6 3364.5 3378.8 3419.0 3627.9 29216.4 29364.9 29436.7 29969.0 30214.0 2790.5 2806.7 2857.0 2873.0 2881.2 460335.0 463053.7 465599.0 468148.3 469425.0 44285.9 44907.6 65001.7 65461.0 65917.0 44623.3 44725.6 44872.3 44879.0 45003.8 15522.3 15634.5 15646.8 15660.5 15673.6 12584.9 12677.8 12684.2 12692.2 12706.6 14536.0 14826.8 14829.7 14859.3 14984.5 6297.7 6404.2 6496.6 6502.5 6511.2 965.8 993.8 998.9 1034.0 1177.2 26476.3 28294.7 29043.6 29152.4 29921.4 944.6 1070.7 1074.9 1120.4 1159.6 11631.3 14722.5 14821.9 15170.6 15205.7 445059.0 509430.0 521651.0 522367.0 524501.0 59149.0 59174.4 59292.3 59365.0 60315.1 1345.2 1467.2 1480.7 1492.4 1497.7 28215.7 28900.9 28923.6 28927.0 29615.0 47343.5 47789.0 48348.0 48356.3 48404.8 316334.0 319301.0 319368.8 319423.0 319846.0 27938.4 28189.2 31256.4 33465.8 33866.8 41111.0 41468.4 41597.4 41850.6 42259.2 33702.0 34922.7 35686.0 36301.5 37073.3 35602.5 35831.3 36136.0 36422.3 36423.5 35257.0 35748.0 35991.3 36292.5 36843.4 27931.7 30510.2 31179.9 31777.0 32133.0 21838.2 23424.3 23940.4 24117.4 24199.4 08:07:35 INFO - PROCESS | 6231 | 08:07:35 INFO - PROCESS | 6231 | [#2] jquery.html Cycles:180 Average:33868.13 Median:24750.63 stddev:103164.44 (416.8%) stddev-sans-first:103423.16 08:07:35 INFO - PROCESS | 6231 | Values: 359.2 362.0 362.6 365.5 374.7 19046.2 19221.7 20380.8 20397.7 20400.9 14678.5 19425.7 19757.7 19764.7 19796.3 5593.8 5893.8 5920.7 5925.8 5925.9 4215.9 4416.4 5833.7 6211.5 6494.7 6397.7 6424.2 6424.8 6431.0 6431.9 6113.7 6381.6 6389.9 6420.3 6427.5 3714.3 5276.7 5486.9 5496.7 5511.0 23948.2 24196.2 24421.8 24725.5 24775.8 2105.6 2164.8 2178.7 2308.8 2819.8 8929.6 9269.4 9442.0 14496.0 14978.5 1452.8 1732.5 1891.6 1898.4 1901.8 94157.5 95284.5 99337.0 99810.0 102188.5 11201.0 11263.9 11283.8 11290.0 11405.5 13375.3 13487.5 13538.9 13568.1 13573.8 8317.0 8478.3 8493.9 8574.1 8577.0 8619.4 8630.4 8657.4 8736.3 8801.9 4243.6 4301.6 4385.7 4424.6 4475.3 1486.8 1745.4 1804.5 1830.6 1856.3 872.3 941.6 943.5 993.2 1086.3 15179.8 17981.0 19865.3 19877.7 20302.6 957.9 962.2 980.2 1009.5 1036.0 8033.8 10497.2 10526.8 10673.5 10715.5 609375.0 614894.0 620642.0 638254.0 640173.0 109124.9 109845.0 110092.4 112130.4 113358.0 1009.2 1024.2 1028.4 1043.2 1045.6 17265.5 17288.7 17539.1 17635.9 17787.9 46143.3 47360.9 47758.5 48728.3 51280.0 62846.7 62926.7 63243.4 63276.7 67016.0 7265.7 7412.8 7431.6 7509.4 7691.3 9832.9 10133.0 11504.8 11948.9 12418.3 10281.4 10509.3 10515.9 10657.1 10763.4 10233.9 10358.9 10404.8 10515.4 10722.6 10415.6 10478.3 10945.1 10998.7 11119.3 7329.3 7410.3 7455.3 7501.8 7621.9 8232.5 10550.7 10591.9 10810.4 10820.9 08:07:35 INFO - PROCESS | 6231 | 08:07:35 INFO - PROCESS | 6231 | [#3] mootools.html Cycles:180 Average:6030.54 Median:5364.18 stddev:3177.67 (59.2%) stddev-sans-first:3167.90 08:07:35 INFO - PROCESS | 6231 | Values: 1445.8 1566.7 1570.1 1834.0 1986.3 7935.8 8580.4 8741.7 8760.0 8764.3 8435.4 8696.4 8722.1 8727.7 8746.9 2135.2 2395.1 2438.3 2477.3 2479.3 2112.9 2439.0 2447.7 2454.0 2454.5 2399.0 2425.8 2435.9 2457.7 2463.5 2117.6 2148.4 2451.9 2461.1 2464.6 2426.7 2427.0 2441.1 2445.2 2445.2 8835.1 8891.4 8902.6 8911.3 8912.3 5364.2 5481.8 5486.1 5486.8 5493.3 3541.2 3612.9 3656.9 3660.6 3693.6 883.6 909.2 1099.5 1602.4 1651.9 11445.1 11478.0 11526.4 11535.6 11590.9 4467.9 4613.1 4673.3 4677.3 4684.0 9226.4 9264.2 9274.2 9274.5 9275.7 5315.9 5316.8 5328.4 5352.0 5364.1 4352.3 4423.0 4424.2 4473.6 4981.6 3726.7 3728.7 3805.6 3835.7 3837.9 1193.4 1204.7 1205.5 1213.9 1215.8 1318.3 1323.0 1361.5 1362.8 1365.7 8199.0 8266.2 8458.8 8462.9 8472.6 1041.7 1151.1 1155.3 1164.8 1188.1 6265.8 6318.5 6326.8 6339.3 6362.2 10418.5 10862.2 10889.5 10958.3 11001.8 10451.3 10724.1 10768.3 10830.8 10840.8 8364.0 8513.0 8532.9 8604.5 8608.2 7974.3 8046.2 8080.8 8139.2 8185.3 9532.0 9605.9 9650.8 9681.6 9904.7 9920.4 9992.7 10025.6 10093.9 10253.4 7098.9 7124.7 7156.6 7181.2 7220.5 8354.1 8382.6 8407.7 8436.4 8475.0 7453.4 7538.2 7631.2 7736.3 7788.7 7169.3 7297.3 7345.7 7349.4 7549.1 7644.4 7720.9 7727.7 7732.3 7737.4 5973.7 6040.3 6931.9 6966.5 7041.5 6371.4 6588.0 7026.4 7097.7 7101.1 08:07:35 INFO - PROCESS | 6231 | 08:07:35 INFO - PROCESS | 6231 | [#4] prototype.html Cycles:180 Average:5776.89 Median:6609.02 stddev:1849.82 (28.0%) stddev-sans-first:1809.08 08:07:35 INFO - PROCESS | 6231 | Values: 318.9 320.7 325.5 328.4 331.2 6420.6 6536.7 6546.2 6570.8 6574.8 6500.9 6624.9 6629.7 6633.4 6644.0 4657.8 4733.2 4743.7 4834.8 4929.5 4831.0 4851.4 4867.9 4896.3 4916.1 4784.2 4807.0 4834.1 4838.0 4839.6 3720.7 4681.3 4790.7 4800.2 4810.6 4072.3 4074.5 4078.8 4089.6 4096.8 5996.1 6352.4 6387.4 6391.4 6401.0 5667.1 5669.5 5674.8 5675.3 5681.5 6787.9 6994.1 7005.0 7017.5 7018.6 4550.0 4643.8 4645.5 4657.3 4660.3 7423.3 7426.3 7433.6 7441.7 7449.4 4692.7 4693.4 4699.4 4703.2 4704.4 4442.7 4528.5 4749.4 4755.8 4758.7 5630.3 5645.9 5646.5 5654.4 5655.8 6821.6 6956.6 7069.4 7070.5 7075.2 1510.6 1651.1 1659.2 1663.8 1664.3 1013.9 1047.9 1082.4 1092.8 1113.9 6476.9 6601.3 6616.8 6696.6 6724.5 7349.2 7361.5 7363.4 7371.6 7378.6 6678.9 6683.4 6687.6 6699.8 6708.8 3760.8 3849.7 3905.4 3912.8 3913.9 7209.6 7709.5 7731.6 7735.2 7737.0 6761.7 6862.3 7569.5 7576.0 7576.7 7676.4 7697.6 7699.7 7710.5 7715.2 7118.8 7344.2 7368.9 7376.0 7380.5 5967.8 7170.2 7240.0 7244.6 7253.1 7672.2 7676.1 7680.6 7687.9 7710.1 4693.7 4702.1 4708.1 4710.3 4712.7 6023.8 7296.2 7312.4 7315.7 7320.5 7009.6 7014.2 7060.6 7064.2 7064.3 7056.0 7065.6 7076.3 7079.5 7080.9 6909.5 6914.0 6920.1 6926.0 6942.2 6830.6 7024.2 7038.8 7075.0 7086.5 6557.9 6719.0 6797.4 6816.3 6923.5 08:07:35 INFO - PROCESS | 6231 | 08:07:35 INFO - PROCESS | 6231 | [#5] yui.html Cycles:180 Average:17652.56 Median:32138.69 stddev:24328.81 (75.7%) stddev-sans-first:24363.58 08:07:35 INFO - PROCESS | 6231 | Values: 656.8 699.0 742.7 775.6 775.8 14540.1 15163.4 15173.3 15174.4 15177.8 13897.1 13969.7 13982.0 13984.7 13985.9 920.5 946.9 969.3 970.7 973.8 763.4 772.4 960.9 962.8 964.3 971.7 991.4 991.4 993.8 995.1 979.0 981.3 982.2 983.2 985.9 594.1 739.9 740.9 748.3 748.7 15194.3 15214.0 15214.5 15256.8 15259.8 12137.4 12187.1 12205.6 12288.9 12430.3 9877.2 9990.8 10001.5 10014.9 10593.4 3435.3 3435.9 3574.4 3632.8 3681.4 65959.0 85531.0 86192.6 86202.6 86432.0 9125.2 9311.3 9379.0 9432.5 9587.4 20907.9 20923.9 20932.4 20933.9 20949.3 6951.2 7026.1 7066.6 7078.4 7181.6 3854.7 3939.2 3952.8 3961.3 4080.9 3284.6 3382.0 3502.3 3594.6 3601.7 642.0 642.7 653.1 653.2 653.2 493.7 567.5 574.1 602.1 615.4 8127.7 8192.1 8285.0 8290.8 8301.3 589.9 595.2 607.5 611.4 629.4 3762.6 3781.5 3835.1 3900.5 3998.9 73515.0 74509.3 74613.3 94533.0 95148.5 70080.6 70349.0 70671.3 73520.0 73735.6 66699.7 67546.0 67739.3 68191.0 68463.7 8389.8 8422.5 8457.5 8493.1 8559.2 48253.5 48433.8 48524.5 49295.5 50010.7 61934.0 63648.0 63990.7 64464.0 64715.7 10786.0 11053.4 11126.7 11170.4 11538.8 11897.3 12064.2 12265.9 12378.4 12411.6 10965.1 11075.4 11319.9 11355.3 11532.8 11289.7 11353.5 11511.8 11757.0 11843.2 11124.9 11241.3 11363.6 11458.0 11681.9 9360.8 9461.5 9563.3 9909.0 10072.0 8424.8 8679.8 9420.7 9614.9 9660.8 08:07:35 INFO - PROCESS | 6231 | -------- Summary: end -------- 08:07:35 INFO - PROCESS | 6231 | 08:07:35 INFO - TEST-INFO | 6231: exit 0 08:07:35 INFO - TEST-OK | dromaeo_css | took 1112946ms 08:07:35 INFO - TEST-START | kraken 08:07:35 INFO - operating with platform_type : mac_ 08:07:35 INFO - Initialising browser for kraken test... 08:07:35 INFO - TEST-INFO | started process 6233 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmpDltKBQ/profile http://localhost:56766/getInfo.html) 08:07:37 INFO - PROCESS | 6233 | __metrics Screen width/height:1600/1200 08:07:37 INFO - PROCESS | 6233 | colorDepth:24 08:07:37 INFO - PROCESS | 6233 | Browser inner width/height: 1024/689 08:07:37 INFO - PROCESS | 6233 | __metrics 08:07:37 INFO - PROCESS | 6233 | 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" 08:07:37 ERROR - PROCESS | 6233 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:07:38 INFO - TEST-INFO | 6233: exit 0 08:07:38 INFO - Browser initialized. 08:07:38 INFO - Running cycle 1/1 for kraken test... 08:07:38 INFO - TEST-INFO | started process 6235 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmpDltKBQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:07:50 INFO - PROCESS | 6235 | RSS: Main: 241807360 08:07:50 INFO - PROCESS | 6235 | 08:07:52 INFO - PROCESS | 6235 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56766/tests/kraken/driver.html?testName=audio-beat-detection) 08:07:53 INFO - PROCESS | 6235 | RSS: Main: 289447936 08:07:53 INFO - PROCESS | 6235 | 08:07:56 INFO - PROCESS | 6235 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56766/tests/kraken/driver.html?testName=audio-dft) 08:07:56 INFO - PROCESS | 6235 | RSS: Main: 300863488 08:07:56 INFO - PROCESS | 6235 | 08:08:00 INFO - PROCESS | 6235 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56766/tests/kraken/driver.html?testName=audio-fft) 08:08:00 INFO - PROCESS | 6235 | RSS: Main: 289640448 08:08:00 INFO - PROCESS | 6235 | 08:08:02 INFO - PROCESS | 6235 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56766/tests/kraken/driver.html?testName=audio-oscillator) 08:08:03 INFO - PROCESS | 6235 | RSS: Main: 291196928 08:08:03 INFO - PROCESS | 6235 | 08:08:05 INFO - PROCESS | 6235 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56766/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:08:06 INFO - PROCESS | 6235 | RSS: Main: 292487168 08:08:06 INFO - PROCESS | 6235 | 08:08:08 INFO - PROCESS | 6235 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56766/tests/kraken/driver.html?testName=imaging-darkroom) 08:08:09 INFO - PROCESS | 6235 | RSS: Main: 291160064 08:08:09 INFO - PROCESS | 6235 | 08:08:12 INFO - PROCESS | 6235 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56766/tests/kraken/driver.html?testName=imaging-desaturate) 08:08:12 INFO - PROCESS | 6235 | RSS: Main: 292810752 08:08:12 INFO - PROCESS | 6235 | 08:08:15 INFO - PROCESS | 6235 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56766/tests/kraken/driver.html?testName=json-parse-financial) 08:08:16 INFO - PROCESS | 6235 | RSS: Main: 292986880 08:08:16 INFO - PROCESS | 6235 | 08:08:17 INFO - PROCESS | 6235 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56766/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:08:18 INFO - PROCESS | 6235 | RSS: Main: 326033408 08:08:18 INFO - PROCESS | 6235 | 08:08:20 INFO - PROCESS | 6235 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56766/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:08:20 INFO - PROCESS | 6235 | RSS: Main: 324902912 08:08:20 INFO - PROCESS | 6235 | 08:08:22 INFO - PROCESS | 6235 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56766/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:08:23 INFO - PROCESS | 6235 | RSS: Main: 332398592 08:08:23 INFO - PROCESS | 6235 | 08:08:26 INFO - PROCESS | 6235 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56766/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:08:26 INFO - PROCESS | 6235 | RSS: Main: 333131776 08:08:26 INFO - PROCESS | 6235 | 08:08:29 INFO - PROCESS | 6235 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56766/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:08:29 INFO - PROCESS | 6235 | RSS: Main: 334426112 08:08:29 INFO - PROCESS | 6235 | 08:08:31 INFO - PROCESS | 6235 | Cycle 1(1): loaded http://localhost:56766/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56766/tests/kraken/driver.html?testName=ai-astar) 08:08:31 INFO - PROCESS | 6235 | RSS: Main: 394862592 08:08:31 INFO - PROCESS | 6235 | 08:08:31 INFO - PROCESS | 6235 | __start_tp_report 08:08:31 INFO - PROCESS | 6235 | _x_x_mozilla_page_load 08:08:31 INFO - PROCESS | 6235 | _x_x_mozilla_page_load_details 08:08:31 INFO - PROCESS | 6235 | |i|pagename|runs| 08:08:31 INFO - PROCESS | 6235 | |0;ai-astar;111;108;111;109;110;112;117;110;112;111 08:08:31 INFO - PROCESS | 6235 | |1;audio-beat-detection;165;155;179;148;138;171;173;121;159;114 08:08:31 INFO - PROCESS | 6235 | |2;audio-dft;184;195;265;206;190;188;185;181;187;182 08:08:31 INFO - PROCESS | 6235 | |3;audio-fft;84;74;104;106;84;83;59;79;77;56 08:08:31 INFO - PROCESS | 6235 | |4;audio-oscillator;97;94;124;79;78;85;112;77;79;114 08:08:31 INFO - PROCESS | 6235 | |5;imaging-gaussian-blur;88;85;88;86;91;85;87;85;88;85 08:08:31 INFO - PROCESS | 6235 | |6;imaging-darkroom;93;93;93;95;94;93;93;94;93;93 08:08:31 INFO - PROCESS | 6235 | |7;imaging-desaturate;85;85;87;85;87;84;85;87;86;85 08:08:31 INFO - PROCESS | 6235 | |8;json-parse-financial;52;53;52;53;53;55;55;63;54;51 08:08:31 INFO - PROCESS | 6235 | |9;json-stringify-tinderbox;64;68;81;76;72;70;69;68;70;70 08:08:31 INFO - PROCESS | 6235 | |10;stanford-crypto-aes;83;81;84;85;85;106;106;82;84;83 08:08:31 INFO - PROCESS | 6235 | |11;stanford-crypto-ccm;131;123;127;143;160;129;111;124;143;112 08:08:31 INFO - PROCESS | 6235 | |12;stanford-crypto-pbkdf2;138;127;139;138;138;127;139;138;133;138 08:08:31 INFO - PROCESS | 6235 | |13;stanford-crypto-sha256-iterative;69;67;65;66;67;68;66;65;66;67 08:08:31 INFO - PROCESS | 6235 | __end_tp_report 08:08:31 INFO - PROCESS | 6235 | __start_cc_report 08:08:31 INFO - PROCESS | 6235 | _x_x_mozilla_cycle_collect,1217 08:08:31 INFO - PROCESS | 6235 | __end_cc_report 08:08:31 INFO - PROCESS | 6235 | __startTimestamp1458140911764__endTimestamp 08:08:31 INFO - PROCESS | 6235 | 08:08:31 INFO - PROCESS | 6235 | ------- Summary: start ------- 08:08:31 INFO - PROCESS | 6235 | Number of tests: 14 08:08:31 INFO - PROCESS | 6235 | 08:08:31 INFO - PROCESS | 6235 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:2.42 (2.2%) stddev-sans-first:2.57 08:08:31 INFO - PROCESS | 6235 | Values: 111.0 108.0 111.0 109.0 110.0 112.0 117.0 110.0 112.0 111.0 08:08:31 INFO - PROCESS | 6235 | 08:08:31 INFO - PROCESS | 6235 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:162.00 stddev:22.05 (13.6%) stddev-sans-first:22.90 08:08:31 INFO - PROCESS | 6235 | Values: 165.0 155.0 179.0 148.0 138.0 171.0 173.0 121.0 159.0 114.0 08:08:31 INFO - PROCESS | 6235 | 08:08:31 INFO - PROCESS | 6235 | [#2] audio-dft Cycles:10 Average:196.30 Median:189.00 stddev:25.23 (13.3%) stddev-sans-first:26.36 08:08:31 INFO - PROCESS | 6235 | Values: 184.0 195.0 265.0 206.0 190.0 188.0 185.0 181.0 187.0 182.0 08:08:31 INFO - PROCESS | 6235 | 08:08:31 INFO - PROCESS | 6235 | [#3] audio-fft Cycles:10 Average:80.60 Median:78.00 stddev:16.17 (20.7%) stddev-sans-first:17.10 08:08:31 INFO - PROCESS | 6235 | Values: 84.0 74.0 104.0 106.0 84.0 83.0 59.0 79.0 77.0 56.0 08:08:31 INFO - PROCESS | 6235 | 08:08:31 INFO - PROCESS | 6235 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:79.00 stddev:17.35 (22.0%) stddev-sans-first:18.37 08:08:31 INFO - PROCESS | 6235 | Values: 97.0 94.0 124.0 79.0 78.0 85.0 112.0 77.0 79.0 114.0 08:08:31 INFO - PROCESS | 6235 | 08:08:31 INFO - PROCESS | 6235 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:87.50 stddev:1.99 (2.3%) stddev-sans-first:2.06 08:08:31 INFO - PROCESS | 6235 | Values: 88.0 85.0 88.0 86.0 91.0 85.0 87.0 85.0 88.0 85.0 08:08:31 INFO - PROCESS | 6235 | 08:08:31 INFO - PROCESS | 6235 | [#6] imaging-darkroom Cycles:10 Average:93.40 Median:93.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 08:08:31 INFO - PROCESS | 6235 | Values: 93.0 93.0 93.0 95.0 94.0 93.0 93.0 94.0 93.0 93.0 08:08:31 INFO - PROCESS | 6235 | 08:08:31 INFO - PROCESS | 6235 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:85.50 stddev:1.07 (1.3%) stddev-sans-first:1.12 08:08:31 INFO - PROCESS | 6235 | Values: 85.0 85.0 87.0 85.0 87.0 84.0 85.0 87.0 86.0 85.0 08:08:31 INFO - PROCESS | 6235 | 08:08:31 INFO - PROCESS | 6235 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:53.50 stddev:3.38 (6.3%) stddev-sans-first:3.50 08:08:31 INFO - PROCESS | 6235 | Values: 52.0 53.0 52.0 53.0 53.0 55.0 55.0 63.0 54.0 51.0 08:08:31 INFO - PROCESS | 6235 | 08:08:31 INFO - PROCESS | 6235 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:70.00 stddev:4.71 (6.7%) stddev-sans-first:4.30 08:08:31 INFO - PROCESS | 6235 | Values: 64.0 68.0 81.0 76.0 72.0 70.0 69.0 68.0 70.0 70.0 08:08:31 INFO - PROCESS | 6235 | 08:08:31 INFO - PROCESS | 6235 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:83.50 stddev:9.62 (11.5%) stddev-sans-first:10.04 08:08:31 INFO - PROCESS | 6235 | Values: 83.0 81.0 84.0 85.0 85.0 106.0 106.0 82.0 84.0 83.0 08:08:31 INFO - PROCESS | 6235 | 08:08:31 INFO - PROCESS | 6235 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:130.00 stddev:14.97 (11.5%) stddev-sans-first:15.88 08:08:31 INFO - PROCESS | 6235 | Values: 131.0 123.0 127.0 143.0 160.0 129.0 111.0 124.0 143.0 112.0 08:08:31 INFO - PROCESS | 6235 | 08:08:31 INFO - PROCESS | 6235 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.50 Median:138.00 stddev:4.79 (3.5%) stddev-sans-first:4.99 08:08:31 INFO - PROCESS | 6235 | Values: 138.0 127.0 139.0 138.0 138.0 127.0 139.0 138.0 133.0 138.0 08:08:31 INFO - PROCESS | 6235 | 08:08:31 INFO - PROCESS | 6235 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.26 (1.9%) stddev-sans-first:1.00 08:08:31 INFO - PROCESS | 6235 | Values: 69.0 67.0 65.0 66.0 67.0 68.0 66.0 65.0 66.0 67.0 08:08:31 INFO - PROCESS | 6235 | -------- Summary: end -------- 08:08:31 INFO - PROCESS | 6235 | 08:08:32 INFO - TEST-INFO | 6235: exit 0 08:08:32 INFO - TEST-OK | kraken | took 56704ms 08:08:32 INFO - SUITE-END | took 1169s 08:08:32 INFO - Completed test suite (00:19:30) 08:08:32 INFO - javascript benchmark 08:08:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3361.428557145285, 3417.7607567470272, 3420.521127042213, 3443.3285509325683, 3490.3891818931697, 5535.501804837564, 5656.575756818244, 5659.745311460983, 5715.457031581998, 5717.971410142949, 5623.80316688916, 5690.829275121742, 5694.060480020791, 5712.428757124286, 5718.857028574288, 5119.38567371915, 5137.743112844343, 5168.250603662466, 5202.869928251786, 5243.9213411798855, 5239.449857764937, 5240.109181439146, 5251.054810134175, 5252.579793616521, 5255.421903590602, 5144.0, 5186.0665080285535, 5211.400688920766, 5216.0, 5238.580913526908, 5256.658317209388, 5280.313559237313, 5289.285946397225, 5292.153255479105, 5344.465553444663, 5085.847424577269, 5091.516305950929, 5111.284420181178, 5193.714345710984, 5226.111561034633, 5602.0196465618355, 5611.663300202001, 5622.9597524457695, 5632.859178520529, 5668.036433806263, 6108.419700128481, 6117.877642447126, 6125.203723515959, 6136.386361363872, 6142.201513803222, 6038.245219347582, 6080.817575472743, 6113.663748493831, 6121.66330851803, 6139.87720245597, 5836.7957121501395, 5868.706564671792, 5871.500922421642, 5887.4406931341455, 5889.734961926681, 6204.720787564571, 6226.439620434183, 6226.533010024266, 6230.0, 6235.719392627343, 5970.910436343458, 6044.214252147192, 6108.5418593605655, 6109.040306147788, 6114.144019837227, 6071.757129714851, 6129.417705317987, 6147.877042459126, 6153.169322141453, 6161.8459538511, 6098.939010609837, 6137.294211165773, 6143.723532441051, 6157.168782214344, 6171.074338849119, 6073.0, 6095.891769653442, 6122.825106970096, 6127.372786728296, 6152.8769424611255, 4848.345473361122, 4878.512148785093, 4896.632752543574, 4910.8281210157475, 4917.1149193145575, 4352.064306174188, 4352.347147927773, 4366.6506679465565, 4369.69412141147, 4411.272140096912, 5579.776808927679, 5672.8865422691315, 5684.573656975661, 5692.686902220417, 5777.711114444261, 6120.69094295093, 6121.910283036266, 6122.916604401382, 6124.564025909317, 6134.957077261001, 5752.252207213036, 5762.366139724627, 5765.625234359753, 5766.279215098113, 5770.740316685759, 4980.12847751642, 5030.396352437658, 5190.766415511311, 5339.466053394707, 5373.2208829719475, 6262.812115636538, 6280.905786413116, 6282.026285925689, 6282.308946015934, 6286.277078136073, 5542.944570554243, 5924.407559244213, 6104.0, 6111.816645500642, 6140.293866205265, 6158.692065396802, 6217.160683307877, 6243.594166379171, 6296.0555916612875, 6320.1467801848, 6078.45293923549, 6098.573099883143, 6129.570930034854, 6145.8156255312415, 6154.446099851035, 6100.481459075851, 6120.724567394389, 6126.6017708848785, 6127.387261273837, 6136.846578835565, 6036.728347224298, 6068.787592434243, 6083.6653984029535, 6105.126180223362, 6121.602095863755, 5910.468057874812, 6057.394260574084, 6083.209182806207, 6101.2068431105445, 6101.359357267423, 5789.131630255495, 5886.470217680429, 5981.641101533922, 5984.850378740566, 5986.700664966647, 4737.763111844325, 5936.673482958478, 6026.668533230714, 6047.697615119138, 6080.574359794949, 5881.852953676193, 5888.440598143169, 5916.112583112567, 5940.940590594038, 5957.76168953237], "unit": "score", "name": "dojo.html", "value": 5650.645364810295}, {"lowerIsBetter": false, "replicates": [478.6410192355733, 520.9739513024348, 591.2668291318766, 635.698043429371, 637.6779726238251, 30415.543766843515, 37860.62139378605, 38021.42967855481, 38100.80949595255, 38191.61808381915, 41924.0, 42541.57458425415, 42548.93627659302, 42580.36129458053, 42613.57386426135, 9580.233581313512, 9769.364991275545, 9796.0, 9805.803883922317, 9811.362261453018, 9508.096730810563, 9690.127888490035, 9695.0, 9696.418214907128, 9700.029997000314, 9671.468069256189, 9864.914859365465, 9874.012598740104, 9883.50582470877, 9907.108360247576, 9786.021397860228, 9786.461744604045, 9845.064718851698, 9849.950750246238, 9872.45701486418, 9688.951555242249, 9820.607175713034, 9824.1649459796, 9830.459324737136, 9842.409455432697, 40733.77798666045, 41107.58892411068, 41118.79440602808, 41166.588334116874, 41250.38124428136, 3263.592050993626, 3364.52896594477, 3378.7972721636534, 3419.008487538611, 3627.9274414511824, 29216.415671686445, 29364.853175733984, 29436.70563294361, 29969.0, 30214.0, 2790.525610646195, 2806.7193280671972, 2857.014330056127, 2873.037532426619, 2881.236472334833, 460335.0, 463053.6847315776, 465599.0, 468148.2518461517, 469425.0, 44285.89285267894, 44907.55092449034, 65001.67499162474, 65461.0, 65917.0, 44623.330650040276, 44725.55274447279, 44872.3269150963, 44879.0, 45003.77498112489, 15522.301496432689, 15634.452794152377, 15646.843531564538, 15660.530184094496, 15673.608159796097, 12584.937075314565, 12677.809832852514, 12684.175528590613, 12692.17500862441, 12706.555270565486, 14535.982481226212, 14826.777598336033, 14829.703405932038, 14859.257037148316, 14984.47554335593, 6297.748090076346, 6404.23149222087, 6496.6426846522945, 6502.479801615859, 6511.218653761579, 965.8164948659733, 993.8459538771502, 998.9200863930868, 1034.04350975349, 1177.2419753822182, 26476.338091547866, 28294.717052829208, 29043.56434653482, 29152.41695166085, 29921.40157196844, 944.607987685103, 1070.7483741320784, 1074.946252687378, 1120.40058568667, 1159.6231224851788, 11631.302121872546, 14722.484713034992, 14821.851781482263, 15170.620734481505, 15205.695886082216, 445059.0, 509430.0, 521651.0, 522367.0, 524501.0, 59149.0, 59174.40825591775, 59292.33184506708, 59365.0, 60315.09527357093, 1345.1727187779445, 1467.156385078584, 1480.7334679757746, 1492.388120870438, 1497.677999230149, 28215.71784282213, 28900.949123980536, 28923.566146507397, 28927.0, 29615.0, 47343.52656473391, 47789.0, 48348.03303933831, 48356.274655880894, 48404.7579762113, 316334.0, 319301.0, 319368.8063119432, 319423.0, 319846.0, 27938.441231175668, 28189.154325370273, 31256.374872502878, 33465.83267083649, 33866.81466148673, 41110.9722256946, 41468.37797432981, 41597.37603935883, 41850.581494185884, 42259.154816902876, 33701.98894033183, 34922.650773492955, 35686.0, 36301.45547816838, 37073.258534828616, 35602.46596301006, 35831.28337433185, 36136.0, 36422.27155456823, 36423.453648194765, 35257.0, 35748.0, 35991.28017439689, 36292.45561316529, 36843.447348290334, 27931.72068279291, 30510.237244069074, 31179.872816198862, 31777.046688599377, 32132.97227749465, 21838.23566175176, 23424.297271081894, 23940.372670807454, 24117.397065073514, 24199.395015124763], "unit": "score", "name": "ext.html", "value": 18839.455074095054}, {"lowerIsBetter": false, "replicates": [359.1685248649378, 361.95113659655937, 362.55949021938346, 365.4992660055724, 374.6721618583739, 19046.238150473982, 19221.711674324877, 20380.796192038077, 20397.694034589495, 20400.89799551, 14678.486252981147, 19425.708614370797, 19757.703634445494, 19764.703529447033, 19796.30712925048, 5593.776248950037, 5893.764249430018, 5920.674362910038, 5925.822225333225, 5925.851853703671, 4215.915681686364, 4416.359627853959, 5833.679147646878, 6211.503079753609, 6494.740210391578, 6397.744090236385, 6424.2290925089055, 6424.839379015515, 6430.967845160791, 6431.903521447182, 6113.724882380304, 6381.553291269613, 6389.904151437732, 6420.26166990795, 6427.485801135898, 3714.275716235335, 5276.736163191825, 5486.890262194734, 5496.670199787985, 5511.0, 23948.161814336414, 24196.15313464038, 24421.778911054374, 24725.5054898901, 24775.752242477523, 2105.631514484974, 2164.8385586339414, 2178.6840908068243, 2308.8037516810923, 2819.830810151377, 8929.642814287421, 9269.397489163182, 9441.952790236073, 14496.0, 14978.47575334858, 1452.8256609206858, 1732.5322163016042, 1891.5743957609566, 1898.411492437349, 1901.8003109673423, 94157.52921235419, 95284.52357738167, 99336.99999999927, 99810.0, 102188.48905755498, 11200.991910727911, 11263.943680281545, 11283.830742538705, 11290.0, 11405.486753096131, 13375.264360460074, 13487.527936522174, 13538.93230533841, 13568.050236483352, 13573.796393054112, 8317.043539992857, 8478.279346255515, 8493.872591911126, 8574.142585741376, 8576.957115214384, 8619.439736417113, 8630.43902146371, 8657.39398242117, 8736.25741811953, 8801.911980880237, 4243.554426785205, 4301.569843015736, 4385.7149285296355, 4424.579664931826, 4475.328700694857, 1486.843881392438, 1745.3978377459755, 1804.5037614656076, 1830.5972686009056, 1856.2853301478758, 872.2803686958284, 941.5527624378502, 943.5376665433888, 993.2203220471895, 1086.3319058778952, 15179.848201517843, 17981.0, 19865.30471433522, 19877.701834472493, 20302.593948120953, 957.9185769209695, 962.2061799015839, 980.1570649241646, 1009.4952523738131, 1036.0261354326908, 8033.799155021171, 10497.212709046851, 10526.842097368546, 10673.519691613896, 10715.46422678863, 609375.0, 614894.0, 620642.0, 638254.0, 640173.0, 109124.90875091306, 109845.0, 110092.4495377518, 112130.43934780273, 113358.0, 1009.152312057875, 1024.1653052761976, 1028.4395004722594, 1043.1811028342865, 1045.5660900726266, 17265.482035538953, 17288.65422691564, 17539.123043848012, 17635.911820440815, 17787.911060444614, 46143.307850382946, 47360.895865620434, 47758.522414775405, 48728.2690759646, 51280.0, 62846.74306513936, 62926.68536657288, 63243.367566323745, 63276.68361658162, 67016.0, 7265.673044713107, 7412.777616671508, 7431.628418579157, 7509.361704254981, 7691.269329413697, 9832.9016709832, 10132.986701330103, 11504.769904602028, 11948.940255298668, 12418.254904705747, 10281.383117013003, 10509.31689440184, 10515.894841051491, 10657.094146997591, 10763.3541987481, 10233.9488302558, 10358.948205258925, 10404.791904162026, 10515.369077855354, 10722.624708135178, 10415.63545275942, 10478.348539599525, 10945.124390048617, 10998.725031874266, 11119.332840029301, 7329.303716146957, 7410.258974102547, 7455.254474552718, 7501.812454688458, 7621.885671714817, 8232.50604963704, 10550.683479495627, 10591.8940810594, 10810.405427701236, 10820.945895270474], "unit": "score", "name": "jquery.html", "value": 9176.93127710342}, {"lowerIsBetter": false, "replicates": [1445.754221782297, 1566.7179907616628, 1570.0893481780568, 1834.0, 1986.2750096214877, 7935.801604959879, 8580.39937204396, 8741.737747867559, 8760.036395996436, 8764.25503832175, 8435.367347448935, 8696.434731742433, 8722.127787221274, 8727.738167854974, 8746.86879696805, 2135.2419890938727, 2395.125779090628, 2438.3050830513353, 2477.331120597438, 2479.3181874984434, 2112.947176320589, 2439.0487709793197, 2447.68180136582, 2453.9754602454013, 2454.47228845799, 2399.0283935006264, 2425.8301918865686, 2435.926922192328, 2457.6559281700575, 2463.470353873917, 2117.6400011998, 2148.398448434441, 2451.8528888266674, 2461.113998960373, 2464.617984212441, 2426.720927093389, 2427.041318679112, 2441.060191826142, 2445.2053082748, 2445.2297526279344, 8835.116488351114, 8891.377603567753, 8902.643894244287, 8911.331650126267, 8912.287017038621, 5364.222187782789, 5481.835544933659, 5486.1222204447495, 5486.847761969991, 5493.285872836545, 3541.203229273393, 3612.9096772580633, 3656.8720094796554, 3660.5607327120915, 3693.649103335179, 883.5802993578063, 909.2135302962955, 1099.483242875847, 1602.3750737212497, 1651.9091449970247, 11445.08439324852, 11477.991351513452, 11526.366049867254, 11535.59625413115, 11590.898864607849, 4467.888302792391, 4613.0773845230415, 4673.345731597579, 4677.298405239241, 4683.976580117078, 9226.40028398152, 9264.166225039779, 9274.21169200612, 9274.536273186313, 9275.72172834816, 5315.893682126413, 5316.787328506894, 5328.387235467971, 5351.983123206578, 5364.14173732201, 4352.303631418958, 4423.0, 4424.247877860707, 4473.619742321874, 4981.576565991859, 3726.7391282610497, 3728.7203459740626, 3805.562360328542, 3835.6931445484292, 3837.9232415351535, 1193.3913704011018, 1204.7108693913397, 1205.5057426455112, 1213.854337479508, 1215.7629262293767, 1318.3013003108367, 1322.966925826862, 1361.5166615851429, 1362.7887677410017, 1365.6995460998564, 8199.0, 8266.214709602578, 8458.788530286793, 8462.87305690415, 8472.576371181416, 1041.6822869024868, 1151.0848875144281, 1155.3356819828632, 1164.796160671879, 1188.0554958807768, 6265.8120256392385, 6318.526110541636, 6326.810195694136, 6339.334369891188, 6362.236531616236, 10418.479076046167, 10862.239643225057, 10889.455527223607, 10958.28771129874, 11001.834972475419, 10451.320664156805, 10724.14206863449, 10768.300060496043, 10830.837537436944, 10840.78318433627, 8364.03813561436, 8513.0, 8532.8720069199, 8604.48373097616, 8608.225259726654, 7974.282314591715, 8046.195380461907, 8080.838383232185, 8139.186081391814, 8185.345172386075, 9532.0, 9605.903940960501, 9650.7587310315, 9681.564329605326, 9904.702858914245, 9920.355176913477, 9992.65099211597, 10025.598976040877, 10093.89906100959, 10253.384796912209, 7098.929010709827, 7124.715011399486, 7156.606386648784, 7181.174164971095, 7220.530665506725, 8354.12281710436, 8382.580870956306, 8407.663693452438, 8436.409451338348, 8475.02537208229, 7453.366463850633, 7538.246175382418, 7631.1605723371495, 7736.2650548197835, 7788.727394541163, 7169.318914703095, 7297.270272972661, 7345.6694448751, 7349.448791340564, 7549.09410870677, 7644.350230230492, 7720.922790772245, 7727.729529466442, 7732.342750866014, 7737.419693523121, 5973.701314934323, 6040.305364882919, 6931.930680693128, 6966.512344135862, 7041.471889608198, 6371.362863713592, 6587.9670601646685, 7026.402755765817, 7097.7160913562875, 7101.11236095488], "unit": "score", "name": "mootools.html", "value": 4927.351771086534}, {"lowerIsBetter": false, "replicates": [318.9394015137124, 320.72417720760143, 325.45161403035877, 328.40722495894914, 331.1935437210394, 6420.614763114217, 6536.7385304587815, 6546.214454265483, 6570.770023049195, 6574.769883054094, 6500.869982600357, 6624.933750662492, 6629.73481060757, 6633.402993730563, 6644.0, 4657.790399432034, 4733.242681171013, 4743.715377077387, 4834.830780922668, 4929.507049295069, 4830.951690483085, 4851.369321988137, 4867.9269810952865, 4896.265560165968, 4916.115099282128, 4784.186688263004, 4806.975965120169, 4834.105690447261, 4837.951620483803, 4839.5644392004715, 3720.7209459290525, 4681.321208424776, 4790.664653474259, 4800.207965685658, 4810.591099756525, 4072.328065869128, 4074.470318858559, 4078.796060197008, 4089.5501494835544, 4096.836126554934, 5996.100584912255, 6352.396522330371, 6387.4251317381195, 6391.424771770517, 6401.039844023388, 5667.064934285879, 5669.489745922846, 5674.801381951653, 5675.262215911905, 5681.460261275172, 6787.864242715118, 6994.0907682001525, 7005.0, 7017.508774385795, 7018.613976231305, 4549.954500455019, 4643.8374656886845, 4645.488996210414, 4657.254839225741, 4660.254359302496, 7423.257674232587, 7426.2945020223, 7433.553986760758, 7441.7023319067175, 7449.441291903129, 4692.718436893797, 4693.436787585443, 4699.436067671902, 4703.2004559225015, 4704.388429504143, 4442.6890117691455, 4528.456585209796, 4749.35883655702, 4755.762211889391, 4758.666893317504, 5630.296212973379, 5645.858853528694, 5646.491815736604, 5654.434556544395, 5655.830325090254, 6821.590704557742, 6956.617386043817, 7069.399101076363, 7070.5404148731195, 7075.2217256101785, 1510.6298956755445, 1651.0506458786247, 1659.1952902842113, 1663.8336166383508, 1664.2926756128838, 1013.9188864890939, 1047.8952104789612, 1082.4479515447022, 1092.847001419802, 1113.8805500471974, 6476.902846457307, 6601.2738598754095, 6616.768413105518, 6696.631685257357, 6724.49566282521, 7349.154847192534, 7361.521501102411, 7363.447741419308, 7371.631418429164, 7378.594177320191, 6678.933210667831, 6683.398494135551, 6687.598744075273, 6699.76550820719, 6708.765193218214, 3760.811959402019, 3849.6920246380223, 3905.3556163233316, 3912.8434862605177, 3913.9217215655526, 7209.639518024078, 7709.4603377763015, 7731.613419329011, 7735.187805280477, 7737.0, 6761.661916904135, 6862.348076932683, 7569.507981981264, 7575.962120189364, 7576.7348142814735, 7676.385889128856, 7697.615119244016, 7699.692012319557, 7710.498817576839, 7715.189905059888, 7118.822029449305, 7344.22885597026, 7368.926310737039, 7375.963120184365, 7380.520266182681, 5967.76128954837, 7170.247124052108, 7240.022596949344, 7244.601546914971, 7253.057102576631, 7672.194419586086, 7676.117246516722, 7680.577568233801, 7687.9231207689445, 7710.11333696632, 4693.741844198602, 4702.106599746037, 4708.058388322418, 4710.340552322609, 4712.670113092051, 6023.849403764941, 7296.233895441114, 7312.378447831994, 7315.743948961761, 7320.450966177452, 7009.614471204132, 7014.193367762773, 7060.6116663584, 7064.152301723826, 7064.32888875556, 7056.0, 7065.6113913735235, 7076.292370763088, 7079.539829911039, 7080.858382832417, 6909.481788865754, 6914.0, 6920.100386949664, 6925.965370173117, 6942.166939967236, 6830.624315662686, 7024.192217894803, 7038.788836334918, 7075.044868942627, 7086.539374940612, 6557.901631475627, 6718.966405167943, 6797.422219111431, 6816.318368163144, 6923.5499692519825], "unit": "score", "name": "prototype.html", "value": 5154.533348667169}, {"lowerIsBetter": false, "replicates": [656.8275628004013, 698.9860202795943, 742.7447613533128, 775.573434610964, 775.7905365551305, 14540.127592344466, 15163.393464261417, 15173.317200725965, 15174.393024279043, 15177.848221517796, 13897.096688715226, 13969.650758731037, 13982.021258511908, 13984.65038374041, 13985.93007034966, 920.4845286639487, 946.8721722567434, 969.2633598465181, 970.7184916374243, 973.8101070291297, 763.4121726270769, 772.3666593393419, 960.8558716192592, 962.7916964209907, 964.3490643815396, 971.6744890461704, 991.3506653142204, 991.3754334769085, 993.7565296502331, 995.0845222395413, 978.9755256118583, 981.293468702533, 982.1700662939804, 983.1790454970109, 985.9457729824857, 594.1177351632822, 739.9260073992612, 740.8925705772687, 748.2891253309377, 748.745426554974, 15194.316255768517, 15214.0, 15214.46749363778, 15256.847431525764, 15259.771103433457, 12137.393130343537, 12187.085968552305, 12205.572804951873, 12288.938555307255, 12430.254184748945, 9877.160441362494, 9990.800183996353, 10001.549930253155, 10014.9499252504, 10593.364398136137, 3435.2957643682985, 3435.9484607730906, 3574.3744844652083, 3632.836522356474, 3681.44778283257, 65959.0, 85531.0, 86192.55229790739, 86202.56898715466, 86432.0, 9125.17873391398, 9311.348205625676, 9379.01520340368, 9432.528373581294, 9587.376820506644, 20907.8954605226, 20923.895380523, 20932.37202883916, 20933.89533052325, 20949.266775662778, 6951.16586009682, 7026.074875331808, 7066.611336376549, 7078.433725302067, 7181.605011724405, 3854.69162467002, 3939.1727737175515, 3952.7825969571372, 3961.3265744823448, 4080.8571699990953, 3284.556584861061, 3381.968499607594, 3502.2820321833965, 3594.5866225383893, 3601.675849173587, 642.0337392224765, 642.7043559962469, 653.0563335979464, 653.2030922274818, 653.2030922274912, 493.6963767283167, 567.5289509707015, 574.1215939612316, 602.1269159718425, 615.3723202333595, 8127.674893004214, 8192.098869124391, 8284.958575207085, 8290.751277461686, 8301.335893128535, 589.8613825750945, 595.220261457492, 607.520059153264, 611.4344231585854, 629.3706293706293, 3762.6049264827348, 3781.5084039074745, 3835.137094153849, 3900.4539364488996, 3998.9200215995515, 73515.0, 74509.25490745132, 74613.25386746171, 94533.0, 95148.52425737827, 70080.59838803195, 70349.0, 70671.2932870675, 73520.0, 73735.63132184412, 66699.66303706588, 67546.0, 67739.3226067733, 68191.0, 68463.65768171127, 8389.790255243424, 8422.473258022692, 8457.450265732708, 8493.108223636676, 8559.229669329541, 48253.5174648249, 48433.75783121203, 48524.514754853415, 49295.507044929094, 50010.749946250035, 61934.0, 63648.0, 63990.68004659947, 64464.0, 64715.67642161759, 10786.029257366874, 11053.392063436588, 11126.666200014013, 11170.441477926233, 11538.82691759641, 11897.286162830258, 12064.215825971283, 12265.896069353801, 12378.381080946097, 12411.62765117048, 10965.067969222706, 11075.446227688744, 11319.886801131883, 11355.261907975955, 11532.769344613229, 11289.661310160709, 11353.48909299067, 11511.769764604493, 11757.0, 11843.23019003762, 11124.944375278072, 11241.269317494336, 11363.602273920373, 11458.026067784333, 11681.88318116808, 9360.765980850261, 9461.451134258865, 9563.282753793354, 9909.009099090033, 10072.043155900177, 8424.809818642338, 8679.783005424915, 9420.670276540288, 9614.855777163488, 9660.806783864144], "unit": "score", "name": "yui.html", "value": 6858.766775625083}], "name": "dromaeo_css", "value": 7444.307232214003}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 111.0, 109.0, 110.0, 112.0, 117.0, 110.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [165.0, 155.0, 179.0, 148.0, 138.0, 171.0, 173.0, 121.0, 159.0, 114.0], "unit": "score", "name": "audio-beat-detection", "value": 152.3}, {"lowerIsBetter": true, "replicates": [184.0, 195.0, 265.0, 206.0, 190.0, 188.0, 185.0, 181.0, 187.0, 182.0], "unit": "score", "name": "audio-dft", "value": 196.3}, {"lowerIsBetter": true, "replicates": [84.0, 74.0, 104.0, 106.0, 84.0, 83.0, 59.0, 79.0, 77.0, 56.0], "unit": "score", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [97.0, 94.0, 124.0, 79.0, 78.0, 85.0, 112.0, 77.0, 79.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 93.9}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 88.0, 86.0, 91.0, 85.0, 87.0, 85.0, 88.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.8}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 93.0, 95.0, 94.0, 93.0, 93.0, 94.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.4}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 87.0, 85.0, 87.0, 84.0, 85.0, 87.0, 86.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.6}, {"lowerIsBetter": true, "replicates": [52.0, 53.0, 52.0, 53.0, 53.0, 55.0, 55.0, 63.0, 54.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 54.1}, {"lowerIsBetter": true, "replicates": [64.0, 68.0, 81.0, 76.0, 72.0, 70.0, 69.0, 68.0, 70.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.8}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 84.0, 85.0, 85.0, 106.0, 106.0, 82.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.9}, {"lowerIsBetter": true, "replicates": [131.0, 123.0, 127.0, 143.0, 160.0, 129.0, 111.0, 124.0, 143.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.3}, {"lowerIsBetter": true, "replicates": [138.0, 127.0, 139.0, 138.0, 138.0, 127.0, 139.0, 138.0, 133.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.5}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 65.0, 66.0, 67.0, 68.0, 66.0, 65.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1445.1999999999998}]} 08:08:33 INFO - Return code: 0 08:08:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:08:33 ERROR - # TBPL SUCCESS # 08:08:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:08:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:08:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:08:33 INFO - 2016-03-16 08:08:33.070 screenresolution[6239:102704] starting screenresolution argv=screenresolution get 08:08:33 INFO - 2016-03-16 08:08:33.073 screenresolution[6239:102704] Display 0: 1600x1200x32@60 08:08:33 INFO - 2016-03-16 08:08:33.078 screenresolution[6240:102707] starting screenresolution argv=screenresolution list 08:08:33 INFO - Available Modes on Display 0 08:08:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:08:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:08:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:08:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:08:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:08:33 INFO - Intel Iris: 08:08:33 INFO - Chipset Model: Intel Iris 08:08:33 INFO - Type: GPU 08:08:33 INFO - Bus: Built-In 08:08:33 INFO - VRAM (Dynamic, Max): 1536 MB 08:08:33 INFO - Vendor: Intel (0x8086) 08:08:33 INFO - Device ID: 0x0a2e 08:08:33 INFO - Revision ID: 0x0009 08:08:33 INFO - Displays: 08:08:33 INFO - Display: 08:08:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:08:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:08:33 INFO - Display Serial Number: 1600x1200 60 08:08:33 INFO - Main Display: Yes 08:08:33 INFO - Mirror: Off 08:08:33 INFO - Online: Yes 08:08:33 INFO - Rotation: Supported 08:08:33 INFO - Return code: 0 08:08:33 INFO - Running post-action listener: _resource_record_post_action 08:08:33 INFO - Running post-run listener: _resource_record_post_run 08:08:34 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 3448320; Write bytes: 703193600; Read time: 65; Write time: 1883 08:08:34 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402291200; Write bytes: 403871232; Read time: 30452; Write time: 734 08:08:34 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 3423744; Write bytes: 298314752; Read time: 61; Write time: 1144 08:08:34 INFO - Running post-run listener: _upload_blobber_files 08:08:34 INFO - Blob upload gear active. 08:08:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:08:34 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 08:08:34 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'] 08:08:34 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 08:08:34 INFO - (blobuploader) - INFO - Open directory for files ... 08:08:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:08:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:08:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:08:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:08:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:08:35 INFO - (blobuploader) - INFO - Done attempting. 08:08:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:08:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:08:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:08:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:08:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:08:36 INFO - (blobuploader) - INFO - Done attempting. 08:08:36 INFO - (blobuploader) - INFO - Iteration through files over. 08:08:36 INFO - Return code: 0 08:08:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:08:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:08:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/300f05cce7c42174f91177161387380cc854b7c85fa583fdb5fb4c071ff468ed0c4a70b161a238df63075b3ad84072163ba6a987914b4eead1f9499533b93465", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cffa65dfdf91476eff6c885e4ffc8fc435657fd4b76ec05800f57a248a391fba34255e88066f442d0faeace16985ea8fe4e889ae8febbee089dcebf5461a778d"} 08:08:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:08:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:08:36 INFO - Contents: 08:08:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/300f05cce7c42174f91177161387380cc854b7c85fa583fdb5fb4c071ff468ed0c4a70b161a238df63075b3ad84072163ba6a987914b4eead1f9499533b93465", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cffa65dfdf91476eff6c885e4ffc8fc435657fd4b76ec05800f57a248a391fba34255e88066f442d0faeace16985ea8fe4e889ae8febbee089dcebf5461a778d"} 08:08:36 INFO - Running post-run listener: copy_logs_to_upload_dir 08:08:36 INFO - Copying logs to upload dir... 08:08:36 INFO - mkdir: /builds/slave/test/build/upload/logs 08:08:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.709363 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-03-16 08:08:36.572655) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 08:08:36.576769) ========= 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.9c2loKL8iY/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.OfDHTjqTqo/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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/300f05cce7c42174f91177161387380cc854b7c85fa583fdb5fb4c071ff468ed0c4a70b161a238df63075b3ad84072163ba6a987914b4eead1f9499533b93465", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cffa65dfdf91476eff6c885e4ffc8fc435657fd4b76ec05800f57a248a391fba34255e88066f442d0faeace16985ea8fe4e889ae8febbee089dcebf5461a778d"} build_url:https://queue.taskcluster.net/v1/task/MooP50vhQACR9nYeUxMfMQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011225 build_url: 'https://queue.taskcluster.net/v1/task/MooP50vhQACR9nYeUxMfMQ/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/300f05cce7c42174f91177161387380cc854b7c85fa583fdb5fb4c071ff468ed0c4a70b161a238df63075b3ad84072163ba6a987914b4eead1f9499533b93465", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cffa65dfdf91476eff6c885e4ffc8fc435657fd4b76ec05800f57a248a391fba34255e88066f442d0faeace16985ea8fe4e889ae8febbee089dcebf5461a778d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 08:08:36.604500) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 08:08:36.604831) ========= 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.9c2loKL8iY/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.OfDHTjqTqo/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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.005199 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 08:08:36.653859) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 08:08:36.654275) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 08:08:36.654764) ========= ========= Total master_lag: 0.29 =========