builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0061 starttime: 1458069499.79 results: success (0) buildid: 20160315110439 builduid: a4ee84b07acb4d7ba4b9b9214b128cca revision: 8c6365c22bb8194b2e9de66b891a3c2c2463145f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 12:18:19.787509) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 12:18:19.787964) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 12:18:19.788381) ========= 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.qpfWFxxHr8/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.zlVGQMKFPT/Listeners TMPDIR=/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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.005831 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 12:18:19.812476) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 12:18:19.812828) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 12:18:19.829150) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 12:18:19.829486) ========= 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.qpfWFxxHr8/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.zlVGQMKFPT/Listeners TMPDIR=/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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.005383 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 12:18:19.878190) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 12:18:19.878546) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 12:18:19.878940) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 12:18:19.879220) ========= 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.qpfWFxxHr8/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.zlVGQMKFPT/Listeners TMPDIR=/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-15 12:18:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 218M=0s 2016-03-15 12:18:20 (218 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156921 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 12:18:20.050958) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 12:18:20.051371) ========= 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.qpfWFxxHr8/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.zlVGQMKFPT/Listeners TMPDIR=/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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.020216 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 12:18:20.099518) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-15 12:18:20.099872) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8c6365c22bb8194b2e9de66b891a3c2c2463145f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8c6365c22bb8194b2e9de66b891a3c2c2463145f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qpfWFxxHr8/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.zlVGQMKFPT/Listeners TMPDIR=/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-15 12:18:20,173 truncating revision to first 12 chars 2016-03-15 12:18:20,173 Setting DEBUG logging. 2016-03-15 12:18:20,173 attempt 1/10 2016-03-15 12:18:20,173 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8c6365c22bb8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-15 12:18:21,235 unpacking tar archive at: mozilla-aurora-8c6365c22bb8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.316269 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-15 12:18:21.435030) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 12:18:21.435383) ========= echo 8c6365c22bb8194b2e9de66b891a3c2c2463145f in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8c6365c22bb8194b2e9de66b891a3c2c2463145f'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qpfWFxxHr8/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.zlVGQMKFPT/Listeners TMPDIR=/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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 8c6365c22bb8194b2e9de66b891a3c2c2463145f program finished with exit code 0 elapsedTime=0.005473 script_repo_revision: '8c6365c22bb8194b2e9de66b891a3c2c2463145f' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 12:18:21.485643) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 12:18:21.485977) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 12:18:21.500469) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-03-15 12:18:21.500864) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qpfWFxxHr8/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.zlVGQMKFPT/Listeners TMPDIR=/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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 12:18:21 INFO - MultiFileLogger online at 20160315 12:18:21 in /builds/slave/test 12:18:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:18:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:18:21 INFO - {'append_to_log': False, 12:18:21 INFO - 'base_work_dir': '/builds/slave/test', 12:18:21 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:18:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:18:21 INFO - 'branch': 'Mozilla-Aurora', 12:18:21 INFO - 'buildbot_json_path': 'buildprops.json', 12:18:21 INFO - 'config_files': ('talos/mac_config.py',), 12:18:21 INFO - 'default_actions': ('clobber', 12:18:21 INFO - 'read-buildbot-config', 12:18:21 INFO - 'download-and-extract', 12:18:21 INFO - 'populate-webroot', 12:18:21 INFO - 'create-virtualenv', 12:18:21 INFO - 'install', 12:18:21 INFO - 'run-tests'), 12:18:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:18:21 INFO - 'download_minidump_stackwalk': True, 12:18:21 INFO - 'download_symbols': 'ondemand', 12:18:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:18:21 INFO - 'tooltool.py': '/tools/tooltool.py', 12:18:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:18:21 INFO - '/tools/misc-python/virtualenv.py')}, 12:18:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:18:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:18:21 INFO - 'installer_path': 'installer.exe', 12:18:21 INFO - 'log_level': 'info', 12:18:21 INFO - 'log_name': 'talos', 12:18:21 INFO - 'log_to_console': True, 12:18:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:18:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:18:21 INFO - 'opt_config_files': (), 12:18:21 INFO - 'pip_index': False, 12:18:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:18:21 INFO - 'cmd': ('bash', 12:18:21 INFO - '-c', 12:18:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:18:21 INFO - 'enabled': True, 12:18:21 INFO - 'halt_on_failure': False, 12:18:21 INFO - 'name': 'check_screen_resolution'},), 12:18:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:18:21 INFO - 'cmd': ('bash', 12:18:21 INFO - '-c', 12:18:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:18:21 INFO - 'enabled': True, 12:18:21 INFO - 'halt_on_failure': False, 12:18:21 INFO - 'name': 'check_screen_resolution'},), 12:18:21 INFO - 'run_cmd_checks_enabled': True, 12:18:21 INFO - 'sps_profile': False, 12:18:21 INFO - 'sps_profile_interval': 0, 12:18:21 INFO - 'suite': 'dromaeojs', 12:18:21 INFO - 'system_bits': '32', 12:18:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:18:21 INFO - 'title': 't-yosemite-r7-0061', 12:18:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:18:21 INFO - 'use_talos_json': True, 12:18:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:18:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:18:21 INFO - 'work_dir': 'build'} 12:18:21 INFO - ##### 12:18:21 INFO - ##### Running clobber step. 12:18:21 INFO - ##### 12:18:21 INFO - Running pre-action listener: _resource_record_pre_action 12:18:21 INFO - Running main action method: clobber 12:18:21 INFO - rmtree: /builds/slave/test/build 12:18:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:18:23 INFO - Running post-action listener: _resource_record_post_action 12:18:23 INFO - ##### 12:18:23 INFO - ##### Running read-buildbot-config step. 12:18:23 INFO - ##### 12:18:23 INFO - Running pre-action listener: _resource_record_pre_action 12:18:23 INFO - Running main action method: read_buildbot_config 12:18:23 INFO - Using buildbot properties: 12:18:23 INFO - { 12:18:23 INFO - "project": "", 12:18:23 INFO - "product": "firefox", 12:18:23 INFO - "script_repo_revision": "production", 12:18:23 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 12:18:23 INFO - "repository": "", 12:18:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 12:18:23 INFO - "buildid": "20160315110439", 12:18:23 INFO - "pgo_build": "False", 12:18:23 INFO - "basedir": "/builds/slave/test", 12:18:23 INFO - "buildnumber": 129, 12:18:23 INFO - "slavename": "t-yosemite-r7-0061", 12:18:23 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 12:18:23 INFO - "platform": "yosemite_r7", 12:18:23 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 12:18:23 INFO - "branch": "mozilla-aurora", 12:18:23 INFO - "repo_path": "releases/mozilla-aurora", 12:18:23 INFO - "revision": "8c6365c22bb8194b2e9de66b891a3c2c2463145f", 12:18:23 INFO - "stage_platform": "macosx64", 12:18:23 INFO - "builduid": "a4ee84b07acb4d7ba4b9b9214b128cca", 12:18:23 INFO - "slavebuilddir": "test" 12:18:23 INFO - } 12:18:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 12:18:23 INFO - Running post-action listener: _resource_record_post_action 12:18:23 INFO - ##### 12:18:23 INFO - ##### Running download-and-extract step. 12:18:23 INFO - ##### 12:18:23 INFO - Running pre-action listener: _resource_record_pre_action 12:18:23 INFO - Running main action method: download_and_extract 12:18:23 INFO - mkdir: /builds/slave/test/build/tests 12:18:23 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')]} 12:18:23 INFO - https://queue.taskcluster.net/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 12:18:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 12:18:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 12:18:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 12:18:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 12:18:25 INFO - Downloaded 1277 bytes. 12:18:25 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 12:18:25 INFO - Using the following test package requirements: 12:18:25 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 12:18:25 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 12:18:25 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 12:18:25 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 12:18:25 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 12:18:25 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 12:18:25 INFO - u'jsshell-mac.zip'], 12:18:25 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 12:18:25 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 12:18:25 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 12:18:25 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 12:18:25 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 12:18:25 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 12:18:25 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 12:18:25 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 12:18:25 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 12:18:25 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 12:18:25 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 12:18:25 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 12:18:25 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 12:18:25 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')]} 12:18:25 INFO - https://queue.taskcluster.net/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:18:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 12:18:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 12:18:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 12:18:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:18:26 INFO - Downloaded 17867137 bytes. 12:18:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:18:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:18:29 INFO - Return code: 0 12:18:29 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 12:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:29 INFO - https://queue.taskcluster.net/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:18:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 12:18:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 12:18:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 12:18:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:18:30 INFO - Downloaded 17867137 bytes. 12:18:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:18:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:18:33 INFO - Return code: 0 12:18:33 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')]} 12:18:33 INFO - https://queue.taskcluster.net/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:18:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 12:18:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 12:18:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 12:18:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 12:18:34 INFO - Downloaded 10845161 bytes. 12:18:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:18:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 12:18:34 INFO - Return code: 0 12:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:34 INFO - https://queue.taskcluster.net/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 12:18:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 12:18:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 12:18:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 12:18:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 12:18:38 INFO - Downloaded 115012118 bytes. 12:18:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 12:18:38 INFO - mkdir: /builds/slave/test/properties 12:18:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:18:38 INFO - Writing to file /builds/slave/test/properties/build_url 12:18:38 INFO - Contents: 12:18:38 INFO - build_url:https://queue.taskcluster.net/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 12:18:39 INFO - Running post-action listener: _resource_record_post_action 12:18:39 INFO - Running post-action listener: set_extra_try_arguments 12:18:39 INFO - ##### 12:18:39 INFO - ##### Running populate-webroot step. 12:18:39 INFO - ##### 12:18:39 INFO - Running pre-action listener: _resource_record_pre_action 12:18:39 INFO - Running main action method: populate_webroot 12:18:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:18:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:18:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:18:39 INFO - '--tppagecycles', 12:18:39 INFO - '7'], 12:18:39 INFO - 'tests': ['tsvgm']}}, 12:18:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:18:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:18:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:18:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:18:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:18:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:18:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:18:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:39 INFO - 'talos_options': ['--e10s'], 12:18:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:18:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:39 INFO - 'tests': ['damp', 'tps']}, 12:18:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:39 INFO - 'talos_options': ['--e10s'], 12:18:39 INFO - 'tests': ['damp', 'tps']}, 12:18:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:18:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:18:39 INFO - 'other': {'tests': ['a11yr', 12:18:39 INFO - 'ts_paint', 12:18:39 INFO - 'tpaint', 12:18:39 INFO - 'sessionrestore', 12:18:39 INFO - 'sessionrestore_no_auto_restore', 12:18:39 INFO - 'tabpaint']}, 12:18:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:18:39 INFO - 'tests': ['a11yr', 12:18:39 INFO - 'ts_paint', 12:18:39 INFO - 'tpaint', 12:18:39 INFO - 'sessionrestore', 12:18:39 INFO - 'sessionrestore_no_auto_restore', 12:18:39 INFO - 'tabpaint']}, 12:18:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:18:39 INFO - 'tests': ['a11yr', 12:18:39 INFO - 'ts_paint', 12:18:39 INFO - 'tpaint', 12:18:39 INFO - 'sessionrestore', 12:18:39 INFO - 'sessionrestore_no_auto_restore', 12:18:39 INFO - 'tabpaint']}, 12:18:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:18:39 INFO - 'tests': ['a11yr', 12:18:39 INFO - 'ts_paint', 12:18:39 INFO - 'tpaint', 12:18:39 INFO - 'sessionrestore', 12:18:39 INFO - 'sessionrestore_no_auto_restore', 12:18:39 INFO - 'tabpaint']}, 12:18:39 INFO - 'other_l64': {'tests': ['a11yr', 12:18:39 INFO - 'ts_paint', 12:18:39 INFO - 'tpaint', 12:18:39 INFO - 'sessionrestore', 12:18:39 INFO - 'sessionrestore_no_auto_restore', 12:18:39 INFO - 'tabpaint']}, 12:18:39 INFO - 'other_nol64': {'tests': ['a11yr', 12:18:39 INFO - 'ts_paint', 12:18:39 INFO - 'tpaint', 12:18:39 INFO - 'sessionrestore', 12:18:39 INFO - 'sessionrestore_no_auto_restore', 12:18:39 INFO - 'tabpaint']}, 12:18:39 INFO - 'svgr': {'tests': ['tsvgx', 12:18:39 INFO - 'tsvgr_opacity', 12:18:39 INFO - 'tart', 12:18:39 INFO - 'tscrollx', 12:18:39 INFO - 'cart']}, 12:18:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:18:39 INFO - 'tests': ['tsvgx', 12:18:39 INFO - 'tsvgr_opacity', 12:18:39 INFO - 'tart', 12:18:39 INFO - 'tscrollx', 12:18:39 INFO - 'cart']}, 12:18:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:39 INFO - 'tests': ['tp5o']}, 12:18:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:39 INFO - 'talos_options': ['--e10s'], 12:18:39 INFO - 'tests': ['tp5o']}, 12:18:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:39 INFO - 'talos_options': ['--xperf_path', 12:18:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:18:39 INFO - 'tests': ['tp5n']}, 12:18:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:39 INFO - 'talos_options': ['--e10s', 12:18:39 INFO - '--xperf_path', 12:18:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:18:39 INFO - 'tests': ['tp5n']}}, 12:18:39 INFO - 'talos.zip': {'path': '', 12:18:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:18:39 INFO - Running post-action listener: _resource_record_post_action 12:18:39 INFO - ##### 12:18:39 INFO - ##### Running create-virtualenv step. 12:18:39 INFO - ##### 12:18:39 INFO - Running pre-action listener: _resource_record_pre_action 12:18:39 INFO - Running main action method: create_virtualenv 12:18:39 INFO - Creating virtualenv /builds/slave/test/build/venv 12:18:39 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 12:18:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:18:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:18:39 INFO - Using real prefix '/tools/python27' 12:18:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:18:40 INFO - Installing distribute.............................................................................................................................................................................................done. 12:18:42 INFO - Installing pip.................done. 12:18:42 INFO - Return code: 0 12:18:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:18:42 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')]} 12:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:42 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')]} 12:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:42 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 0x10ff7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff864c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5aa590070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe23d30>, '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 0x10fc87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe1ab20>, '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.qpfWFxxHr8/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.zlVGQMKFPT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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 12:18:42 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 12:18:42 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 12:18:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qpfWFxxHr8/Render', 12:18:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:42 INFO - 'HOME': '/Users/cltbld', 12:18:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:42 INFO - 'LOGNAME': 'cltbld', 12:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:42 INFO - 'MOZ_NO_REMOTE': '1', 12:18:42 INFO - 'NO_EM_RESTART': '1', 12:18:42 INFO - 'PAGER': '/bin/cat', 12:18:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:42 INFO - 'PWD': '/builds/slave/test', 12:18:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:42 INFO - 'SHELL': '/bin/bash', 12:18:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zlVGQMKFPT/Listeners', 12:18:42 INFO - 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/', 12:18:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:42 INFO - 'USER': 'cltbld', 12:18:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:42 INFO - 'XPC_FLAGS': '0x0', 12:18:42 INFO - 'XPC_SERVICE_NAME': '0', 12:18:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:43 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 12:18:43 INFO - Cleaning up... 12:18:43 INFO - Return code: 0 12:18:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:18: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')]} 12:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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')]} 12:18:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ff7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff864c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5aa590070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe23d30>, '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 0x10fc87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe1ab20>, '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.qpfWFxxHr8/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.zlVGQMKFPT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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 12:18:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:18:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:18:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qpfWFxxHr8/Render', 12:18:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:43 INFO - 'HOME': '/Users/cltbld', 12:18:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:43 INFO - 'LOGNAME': 'cltbld', 12:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:43 INFO - 'MOZ_NO_REMOTE': '1', 12:18:43 INFO - 'NO_EM_RESTART': '1', 12:18:43 INFO - 'PAGER': '/bin/cat', 12:18:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:43 INFO - 'PWD': '/builds/slave/test', 12:18:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:43 INFO - 'SHELL': '/bin/bash', 12:18:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zlVGQMKFPT/Listeners', 12:18:43 INFO - 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/', 12:18:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:43 INFO - 'USER': 'cltbld', 12:18:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:43 INFO - 'XPC_FLAGS': '0x0', 12:18:43 INFO - 'XPC_SERVICE_NAME': '0', 12:18:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:43 INFO - Downloading/unpacking psutil>=0.7.1 12:18:43 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 12:18:43 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 12:18:43 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 12:18:43 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 12:18:43 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 12:18:43 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 12:18:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:18:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:18:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:18:45 INFO - Installing collected packages: psutil 12:18:45 INFO - Running setup.py install for psutil 12:18:45 INFO - building 'psutil._psutil_osx' extension 12:18:45 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 12:18:46 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 12:18:46 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 12:18:46 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 12:18:46 INFO - building 'psutil._psutil_posix' extension 12:18:46 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 12:18:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:18:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:18:46 INFO - ^ 12:18:46 INFO - 1 warning generated. 12:18:46 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 12:18:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:18:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:18:46 INFO - Successfully installed psutil 12:18:46 INFO - Cleaning up... 12:18:46 INFO - Return code: 0 12:18:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:18:46 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')]} 12:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:46 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')]} 12:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:46 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 0x10ff7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff864c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5aa590070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe23d30>, '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 0x10fc87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe1ab20>, '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.qpfWFxxHr8/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.zlVGQMKFPT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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 12:18:46 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 12:18:46 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 12:18:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qpfWFxxHr8/Render', 12:18:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:46 INFO - 'HOME': '/Users/cltbld', 12:18:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:46 INFO - 'LOGNAME': 'cltbld', 12:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:46 INFO - 'MOZ_NO_REMOTE': '1', 12:18:46 INFO - 'NO_EM_RESTART': '1', 12:18:46 INFO - 'PAGER': '/bin/cat', 12:18:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:46 INFO - 'PWD': '/builds/slave/test', 12:18:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:46 INFO - 'SHELL': '/bin/bash', 12:18:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zlVGQMKFPT/Listeners', 12:18:46 INFO - 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/', 12:18:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:46 INFO - 'USER': 'cltbld', 12:18:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:46 INFO - 'XPC_FLAGS': '0x0', 12:18:46 INFO - 'XPC_SERVICE_NAME': '0', 12:18:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:18:49 INFO - Installing collected packages: mozsystemmonitor 12:18:49 INFO - Running setup.py install for mozsystemmonitor 12:18:49 INFO - Successfully installed mozsystemmonitor 12:18:49 INFO - Cleaning up... 12:18:49 INFO - Return code: 0 12:18:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:18: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')]} 12:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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')]} 12:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:49 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 0x10ff7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff864c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5aa590070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe23d30>, '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 0x10fc87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe1ab20>, '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.qpfWFxxHr8/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.zlVGQMKFPT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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 12:18:49 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 12:18:49 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 12:18:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qpfWFxxHr8/Render', 12:18:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:49 INFO - 'HOME': '/Users/cltbld', 12:18:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:49 INFO - 'LOGNAME': 'cltbld', 12:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:49 INFO - 'MOZ_NO_REMOTE': '1', 12:18:49 INFO - 'NO_EM_RESTART': '1', 12:18:49 INFO - 'PAGER': '/bin/cat', 12:18:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:49 INFO - 'PWD': '/builds/slave/test', 12:18:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:49 INFO - 'SHELL': '/bin/bash', 12:18:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zlVGQMKFPT/Listeners', 12:18:49 INFO - 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/', 12:18:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:49 INFO - 'USER': 'cltbld', 12:18:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:49 INFO - 'XPC_FLAGS': '0x0', 12:18:49 INFO - 'XPC_SERVICE_NAME': '0', 12:18:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:49 INFO - Downloading/unpacking blobuploader==1.2.4 12:18:49 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 12:18:49 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 12:18:49 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 12:18:49 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 12:18:49 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 12:18:49 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 12:18:52 INFO - Downloading blobuploader-1.2.4.tar.gz 12:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:18:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:18:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:18:53 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 12:18:53 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 12:18:53 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 12:18:53 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 12:18:53 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 12:18:53 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 12:18:53 INFO - Downloading docopt-0.6.1.tar.gz 12:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:18:53 INFO - Installing collected packages: blobuploader, requests, docopt 12:18:53 INFO - Running setup.py install for blobuploader 12:18:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:18:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:18:53 INFO - Running setup.py install for requests 12:18:54 INFO - Running setup.py install for docopt 12:18:54 INFO - Successfully installed blobuploader requests docopt 12:18:54 INFO - Cleaning up... 12:18:54 INFO - Return code: 0 12:18:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:54 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 0x10ff7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff864c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5aa590070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe23d30>, '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 0x10fc87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe1ab20>, '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.qpfWFxxHr8/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.zlVGQMKFPT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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 12:18:54 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 12:18:54 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 12:18:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qpfWFxxHr8/Render', 12:18:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:54 INFO - 'HOME': '/Users/cltbld', 12:18:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:54 INFO - 'LOGNAME': 'cltbld', 12:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:54 INFO - 'MOZ_NO_REMOTE': '1', 12:18:54 INFO - 'NO_EM_RESTART': '1', 12:18:54 INFO - 'PAGER': '/bin/cat', 12:18:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:54 INFO - 'PWD': '/builds/slave/test', 12:18:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:54 INFO - 'SHELL': '/bin/bash', 12:18:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zlVGQMKFPT/Listeners', 12:18:54 INFO - 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/', 12:18:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:54 INFO - 'USER': 'cltbld', 12:18:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:54 INFO - 'XPC_FLAGS': '0x0', 12:18:54 INFO - 'XPC_SERVICE_NAME': '0', 12:18:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:18:54 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-Q8vAjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:18:54 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-ez9CaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:18:54 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-WPHvlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:18:55 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-yYEq7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:18:55 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-aMCEIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:18:55 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-Hs92Vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:18:55 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-lrlRE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:18:55 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-idtq1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:18:55 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-HhBTKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:18:55 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-x6ukie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:18:55 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-VYTKLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:18:55 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-yX9RNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:18:55 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-rXfNtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:18:56 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-zD_4XJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:18:56 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-Vf0CGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:18:56 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-t6RmIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:18:56 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-U3iyJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:18:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:18:56 INFO - Running setup.py install for manifestparser 12:18:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:18:56 INFO - Running setup.py install for mozcrash 12:18:56 INFO - Running setup.py install for mozdebug 12:18:56 INFO - Running setup.py install for mozdevice 12:18:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:18:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:18:57 INFO - Running setup.py install for mozfile 12:18:57 INFO - Running setup.py install for mozhttpd 12:18:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:18:57 INFO - Running setup.py install for mozinfo 12:18:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:18:57 INFO - Running setup.py install for mozInstall 12:18:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:18:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:18:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:18:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:18:57 INFO - Running setup.py install for mozleak 12:18:57 INFO - Running setup.py install for mozlog 12:18:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:18:57 INFO - Running setup.py install for moznetwork 12:18:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:18:58 INFO - Running setup.py install for mozprocess 12:18:58 INFO - Running setup.py install for mozprofile 12:18:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:18:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:18:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:18:58 INFO - Running setup.py install for mozrunner 12:18:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:18:58 INFO - Running setup.py install for mozscreenshot 12:18:58 INFO - Running setup.py install for moztest 12:18:58 INFO - Running setup.py install for mozversion 12:18:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:18:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:18:59 INFO - Cleaning up... 12:18:59 INFO - Return code: 0 12:18:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:59 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 0x10ff7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff864c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5aa590070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe23d30>, '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 0x10fc87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe1ab20>, '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.qpfWFxxHr8/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.zlVGQMKFPT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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 12:18:59 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 12:18:59 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 12:18:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qpfWFxxHr8/Render', 12:18:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:59 INFO - 'HOME': '/Users/cltbld', 12:18:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:59 INFO - 'LOGNAME': 'cltbld', 12:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:59 INFO - 'MOZ_NO_REMOTE': '1', 12:18:59 INFO - 'NO_EM_RESTART': '1', 12:18:59 INFO - 'PAGER': '/bin/cat', 12:18:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:59 INFO - 'PWD': '/builds/slave/test', 12:18:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:59 INFO - 'SHELL': '/bin/bash', 12:18:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zlVGQMKFPT/Listeners', 12:18:59 INFO - 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/', 12:18:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:59 INFO - 'USER': 'cltbld', 12:18:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:59 INFO - 'XPC_FLAGS': '0x0', 12:18:59 INFO - 'XPC_SERVICE_NAME': '0', 12:18:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:18:59 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-4JWbcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:18:59 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)) 12:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:18:59 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-PZRZmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:18:59 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)) 12:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:18:59 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-kHJL5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:18:59 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)) 12:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:18:59 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-tkxurU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:18:59 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)) 12:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:18:59 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-n7CflN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:18:59 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)) 12:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:18:59 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-LLCIAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:18:59 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)) 12:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:18:59 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-Wjg0RP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:00 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)) 12:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:00 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-2eP1kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:00 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)) 12:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:00 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-K2KqtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:00 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)) 12:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:00 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-qGjlYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:00 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)) 12:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:00 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-TjVd6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:00 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)) 12:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:00 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-YUR4zT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:00 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)) 12:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:00 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-PP_8Fk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:00 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)) 12:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:00 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-QSt8iQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:00 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)) 12:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:00 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-IUYMTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:00 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)) 12:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:00 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-mSWpKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:00 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)) 12:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:00 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-GQJ90L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:01 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)) 12:19:01 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)) 12:19:01 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)) 12:19:01 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)) 12:19:01 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)) 12:19:01 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)) 12:19:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19:03 INFO - Downloading blessings-1.6.tar.gz 12:19:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:19:03 INFO - Installing collected packages: blessings 12:19:03 INFO - Running setup.py install for blessings 12:19:03 INFO - Successfully installed blessings 12:19:03 INFO - Cleaning up... 12:19:04 INFO - Return code: 0 12:19:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:19:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:19:04 INFO - Reading from file tmpfile_stdout 12:19:04 INFO - Current package versions: 12:19:04 INFO - blessings == 1.6 12:19:04 INFO - blobuploader == 1.2.4 12:19:04 INFO - docopt == 0.6.1 12:19:04 INFO - manifestparser == 1.1 12:19:04 INFO - mozInstall == 1.12 12:19:04 INFO - mozcrash == 0.17 12:19:04 INFO - mozdebug == 0.1 12:19:04 INFO - mozdevice == 0.48 12:19:04 INFO - mozfile == 1.2 12:19:04 INFO - mozhttpd == 0.7 12:19:04 INFO - mozinfo == 0.9 12:19:04 INFO - mozleak == 0.1 12:19:04 INFO - mozlog == 3.1 12:19:04 INFO - moznetwork == 0.27 12:19:04 INFO - mozprocess == 0.22 12:19:04 INFO - mozprofile == 0.28 12:19:04 INFO - mozrunner == 6.11 12:19:04 INFO - mozscreenshot == 0.1 12:19:04 INFO - mozsystemmonitor == 0.0 12:19:04 INFO - moztest == 0.7 12:19:04 INFO - mozversion == 1.4 12:19:04 INFO - psutil == 3.1.1 12:19:04 INFO - requests == 1.2.3 12:19:04 INFO - wsgiref == 0.1.2 12:19:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19: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')]} 12:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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')]} 12:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:04 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 0x10ff7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff864c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5aa590070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe23d30>, '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 0x10fc87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe1ab20>, '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.qpfWFxxHr8/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.zlVGQMKFPT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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 12:19:04 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 12:19:04 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 12:19:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qpfWFxxHr8/Render', 12:19:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:19:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:19:04 INFO - 'HOME': '/Users/cltbld', 12:19:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:19:04 INFO - 'LOGNAME': 'cltbld', 12:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:04 INFO - 'MOZ_NO_REMOTE': '1', 12:19:04 INFO - 'NO_EM_RESTART': '1', 12:19:04 INFO - 'PAGER': '/bin/cat', 12:19:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:04 INFO - 'PWD': '/builds/slave/test', 12:19:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:19:04 INFO - 'SHELL': '/bin/bash', 12:19:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zlVGQMKFPT/Listeners', 12:19:04 INFO - 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/', 12:19:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:19:04 INFO - 'USER': 'cltbld', 12:19:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:19:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:04 INFO - 'XPC_FLAGS': '0x0', 12:19:04 INFO - 'XPC_SERVICE_NAME': '0', 12:19:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:04 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)) 12:19:04 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)) 12:19:04 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)) 12:19:04 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)) 12:19:04 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)) 12:19:04 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)) 12:19:04 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)) 12:19:04 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)) 12:19:04 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)) 12:19:04 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)) 12:19:04 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)) 12:19:04 INFO - Cleaning up... 12:19:04 INFO - Return code: 0 12:19:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:19: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')]} 12:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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')]} 12:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ff7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff864c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5aa590070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe23d30>, '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 0x10fc87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe1ab20>, '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.qpfWFxxHr8/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.zlVGQMKFPT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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 12:19: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', 'jsonschema'] in /builds/slave/test/build 12:19: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 jsonschema 12:19:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qpfWFxxHr8/Render', 12:19:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:19:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:19:04 INFO - 'HOME': '/Users/cltbld', 12:19:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:19:04 INFO - 'LOGNAME': 'cltbld', 12:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:04 INFO - 'MOZ_NO_REMOTE': '1', 12:19:04 INFO - 'NO_EM_RESTART': '1', 12:19:04 INFO - 'PAGER': '/bin/cat', 12:19:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:04 INFO - 'PWD': '/builds/slave/test', 12:19:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:19:04 INFO - 'SHELL': '/bin/bash', 12:19:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zlVGQMKFPT/Listeners', 12:19:04 INFO - 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/', 12:19:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:19:04 INFO - 'USER': 'cltbld', 12:19:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:19:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:04 INFO - 'XPC_FLAGS': '0x0', 12:19:04 INFO - 'XPC_SERVICE_NAME': '0', 12:19:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:04 INFO - Downloading/unpacking jsonschema 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:19:07 INFO - Downloading/unpacking functools32 (from jsonschema) 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19:07 INFO - Downloading functools32-3.2.3-2.tar.gz 12:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:19:07 INFO - warning: no files found matching '*.txt' 12:19:07 INFO - no previously-included directories found matching 'build' 12:19:07 INFO - no previously-included directories found matching 'dist' 12:19:07 INFO - no previously-included directories found matching '.git*' 12:19:07 INFO - Installing collected packages: jsonschema, functools32 12:19:07 INFO - Running setup.py install for functools32 12:19:07 INFO - warning: no files found matching '*.txt' 12:19:07 INFO - no previously-included directories found matching 'build' 12:19:07 INFO - no previously-included directories found matching 'dist' 12:19:07 INFO - no previously-included directories found matching '.git*' 12:19:07 INFO - Successfully installed jsonschema functools32 12:19:07 INFO - Cleaning up... 12:19:07 INFO - Return code: 0 12:19:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ff7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff864c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5aa590070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe23d30>, '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 0x10fc87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe1ab20>, '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.qpfWFxxHr8/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.zlVGQMKFPT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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 12:19:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:19:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qpfWFxxHr8/Render', 12:19:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:19:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:19:07 INFO - 'HOME': '/Users/cltbld', 12:19:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:19:07 INFO - 'LOGNAME': 'cltbld', 12:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:07 INFO - 'MOZ_NO_REMOTE': '1', 12:19:07 INFO - 'NO_EM_RESTART': '1', 12:19:07 INFO - 'PAGER': '/bin/cat', 12:19:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:07 INFO - 'PWD': '/builds/slave/test', 12:19:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:19:07 INFO - 'SHELL': '/bin/bash', 12:19:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zlVGQMKFPT/Listeners', 12:19:07 INFO - 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/', 12:19:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:19:07 INFO - 'USER': 'cltbld', 12:19:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:19:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:07 INFO - 'XPC_FLAGS': '0x0', 12:19:07 INFO - 'XPC_SERVICE_NAME': '0', 12:19:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:08 INFO - Downloading/unpacking flake8 12:19:08 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 12:19:08 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 12:19:08 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 12:19:08 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 12:19:08 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 12:19:08 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 12:19:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:19:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:19:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:19:11 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 12:19:11 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 12:19:11 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 12:19:11 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 12:19:11 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 12:19:11 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 12:19:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:19:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:19:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:19:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:19:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:19:11 INFO - no previously-included directories found matching 'docs/_build' 12:19:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:19:11 INFO - Running setup.py install for pep8 12:19:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:19:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:19:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:19:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:19:12 INFO - no previously-included directories found matching 'docs/_build' 12:19:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:19:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:19:12 INFO - Cleaning up... 12:19:12 INFO - Return code: 0 12:19:12 INFO - Running post-action listener: _resource_record_post_action 12:19:12 INFO - Running post-action listener: _start_resource_monitoring 12:19:12 INFO - Starting resource monitoring. 12:19:12 INFO - ##### 12:19:12 INFO - ##### Running install step. 12:19:12 INFO - ##### 12:19:12 INFO - Running pre-action listener: _resource_record_pre_action 12:19:12 INFO - Running main action method: install 12:19:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:19:12 INFO - Reading from file tmpfile_stdout 12:19:12 INFO - Detecting whether we're running mozinstall >=1.0... 12:19:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:19:12 INFO - Reading from file tmpfile_stdout 12:19:12 INFO - Output received: 12:19:12 INFO - Usage: mozinstall [options] installer 12:19:12 INFO - Options: 12:19:12 INFO - -h, --help show this help message and exit 12:19:12 INFO - -d DEST, --destination=DEST 12:19:12 INFO - Directory to install application into. [default: 12:19:12 INFO - "/builds/slave/test"] 12:19:12 INFO - --app=APP Application being installed. [default: firefox] 12:19:12 INFO - mkdir: /builds/slave/test/build/application 12:19:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 12:19:45 INFO - Reading from file tmpfile_stdout 12:19:45 INFO - Output received: 12:19:45 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 12:19:45 INFO - Running post-action listener: _resource_record_post_action 12:19:45 INFO - ##### 12:19:45 INFO - ##### Running run-tests step. 12:19:45 INFO - ##### 12:19:45 INFO - Running pre-action listener: _resource_record_pre_action 12:19:45 INFO - Running main action method: run_tests 12:19:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:19:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:19:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:19:45 INFO - 2016-03-15 12:19:45.096 screenresolution[1982:10570] starting screenresolution argv=screenresolution get 12:19:45 INFO - 2016-03-15 12:19:45.098 screenresolution[1982:10570] Display 0: 1600x1200x32@60 12:19:45 INFO - 2016-03-15 12:19:45.104 screenresolution[1983:10572] starting screenresolution argv=screenresolution list 12:19:45 INFO - Available Modes on Display 0 12:19:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:19:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:19:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:19:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:19:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:19:45 INFO - Intel Iris: 12:19:45 INFO - Chipset Model: Intel Iris 12:19:45 INFO - Type: GPU 12:19:45 INFO - Bus: Built-In 12:19:45 INFO - VRAM (Dynamic, Max): 1536 MB 12:19:45 INFO - Vendor: Intel (0x8086) 12:19:45 INFO - Device ID: 0x0a2e 12:19:45 INFO - Revision ID: 0x0009 12:19:45 INFO - Displays: 12:19:45 INFO - Display: 12:19:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:19:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:19:45 INFO - Display Serial Number: 1600x1200 60 12:19:45 INFO - Main Display: Yes 12:19:45 INFO - Mirror: Off 12:19:45 INFO - Online: Yes 12:19:45 INFO - Rotation: Supported 12:19:45 INFO - Return code: 0 12:19:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:19:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:19:45 INFO - Python 2.7.3 12:19:45 INFO - Return code: 0 12:19:45 INFO - grabbing minidump binary from tooltool 12:19:45 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')]} 12:19:45 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 0x10fe23d30>, '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 0x10fc87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe1ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:19:45 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 12:19:45 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 12:19:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:19:45 INFO - Return code: 0 12:19:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:19:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:19:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:19:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:19:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:19:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:19:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:19:46 INFO - Return code: 0 12:19:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--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 12:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0061 --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 12:19:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qpfWFxxHr8/Render', 12:19:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:19:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:19:46 INFO - 'HOME': '/Users/cltbld', 12:19:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:19:46 INFO - 'LOGNAME': 'cltbld', 12:19:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:19:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:46 INFO - 'MOZ_NO_REMOTE': '1', 12:19:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:19:46 INFO - 'NO_EM_RESTART': '1', 12:19:46 INFO - 'PAGER': '/bin/cat', 12:19:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:46 INFO - 'PWD': '/builds/slave/test', 12:19:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:19:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:19:46 INFO - 'SHELL': '/bin/bash', 12:19:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zlVGQMKFPT/Listeners', 12:19:46 INFO - 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/', 12:19:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:19:46 INFO - 'USER': 'cltbld', 12:19:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:19:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:46 INFO - 'XPC_FLAGS': '0x0', 12:19:46 INFO - 'XPC_SERVICE_NAME': '0', 12:19:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:19:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--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 12:19:46 INFO - mozversion application_buildid: 20160315110439 12:19:46 INFO - mozversion application_changeset: 8c6365c22bb8194b2e9de66b891a3c2c2463145f 12:19:46 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:19:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:19:46 INFO - mozversion application_name: Firefox 12:19:46 INFO - mozversion application_remotingname: firefox-dev 12:19:46 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:19:46 INFO - mozversion application_vendor: Mozilla 12:19:46 INFO - mozversion application_version: 47.0a2 12:19:46 INFO - mozversion platform_buildid: 20160315110439 12:19:46 INFO - mozversion platform_changeset: 8c6365c22bb8194b2e9de66b891a3c2c2463145f 12:19:46 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:19:46 INFO - mozversion platform_version: 47.0a2 12:19:46 INFO - using testdate: 1458069586 12:19:46 INFO - actual date: 1458069586 12:19:46 INFO - starting webserver on 'localhost:49392' 12:19:46 INFO - SUITE-START | Running 2 tests 12:19:46 INFO - TEST-START | dromaeo_css 12:19:46 INFO - operating with platform_type : mac_ 12:19:46 INFO - Initialising browser for dromaeo_css test... 12:19:46 INFO - TEST-INFO | started process 2001 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/tmptEeLqD/profile http://localhost:49392/getInfo.html) 12:19:48 INFO - PROCESS | 2001 | __metrics Screen width/height:1600/1200 12:19:48 INFO - PROCESS | 2001 | colorDepth:24 12:19:48 INFO - PROCESS | 2001 | Browser inner width/height: 1024/689 12:19:48 INFO - PROCESS | 2001 | __metrics 12:19:49 INFO - PROCESS | 2001 | 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" 12:19:49 INFO - PROCESS | 2001 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:19:49 INFO - TEST-INFO | 2001: exit 0 12:19:49 INFO - Browser initialized. 12:19:49 INFO - Running cycle 1/1 for dromaeo_css test... 12:19:49 INFO - TEST-INFO | started process 2003 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/tmptEeLqD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:20:01 INFO - PROCESS | 2003 | RSS: Main: 209084416 12:20:01 INFO - PROCESS | 2003 | 12:20:53 INFO - PROCESS | 2003 | 1458069653154 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] 12:23:04 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49392/tests/dromaeo/cssquery-ext.html) 12:23:05 INFO - PROCESS | 2003 | RSS: Main: 336613376 12:23:05 INFO - PROCESS | 2003 | 12:26:08 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-ext.html (next: http://localhost:49392/tests/dromaeo/cssquery-jquery.html) 12:26:08 INFO - PROCESS | 2003 | RSS: Main: 343740416 12:26:08 INFO - PROCESS | 2003 | 12:29:10 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49392/tests/dromaeo/cssquery-mootools.html) 12:29:11 INFO - PROCESS | 2003 | RSS: Main: 347545600 12:29:11 INFO - PROCESS | 2003 | 12:32:13 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49392/tests/dromaeo/cssquery-prototype.html) 12:32:13 INFO - PROCESS | 2003 | RSS: Main: 309624832 12:32:13 INFO - PROCESS | 2003 | 12:35:16 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49392/tests/dromaeo/cssquery-yui.html) 12:35:17 INFO - PROCESS | 2003 | RSS: Main: 308940800 12:35:17 INFO - PROCESS | 2003 | 12:38:20 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-yui.html (next: http://localhost:49392/tests/dromaeo/cssquery-dojo.html) 12:38:20 INFO - PROCESS | 2003 | RSS: Main: 355127296 12:38:20 INFO - PROCESS | 2003 | 12:38:20 INFO - PROCESS | 2003 | __start_tp_report 12:38:20 INFO - PROCESS | 2003 | _x_x_mozilla_page_load 12:38:20 INFO - PROCESS | 2003 | _x_x_mozilla_page_load_details 12:38:20 INFO - PROCESS | 2003 | |i|pagename|runs| 12:38:20 INFO - PROCESS | 2003 | |0;dojo.html;3447.052060683312;3512.2799826035666;3513.7189024878;3562.3943929531983;3600.4419315006185;5917.2307600012045;5943.524518038563;5962.850928726784;5965.403459654032;5975.37258587848;5933.080372542263;5982.521398288138;5989.730462129204;5992.250968628921;5998.100284957259;5180.896382072357;5272.024675435047;5284.339457567804;5348.090824559834;5396.541293990015;5297.761600727958;5378.0857254266675;5395.59533035022;5416.187571864232;5417.349918009844;5394;5416.8104116355935;5422.40353561108;5423.267858839065;5436.809711660093;5368.543673787733;5384.623076384654;5392.757325920343;5399.19012148177;5470.507654311092;5149.30484384607;5204.895902081975;5321.281626980347;5324.41431442541;5340.065488539529;5748.683822389767;5758.769649214027;5839.503642190419;5849.385814489502;5874.882502349972;6183.96908015457;6254.530910181755;6263.874722505524;6275.529335299871;6277.403646653561;5946.762129514815;6199.907001394983;6222.097795819581;6284.717187726564;6319.494440444753;5993.700314984277;6073.134009451069;6085.695715214221;6105.542084343692;6125.601835880653;6380.361963803675;6390.5526613136635;6394.104825324458;6397.6801159941815;6406.967965160145;6174.598651087665;6228.626282423069;6266.248050234001;6307.779227727007;6312.936870631327;6272.059191121277;6274.811755647338;6275.623462592259;6295.401936815995;6308.558400911984;6210.844728881814;6213.65824879627;6242.15730876335;6261.029540421242;6265.122882796412;6198.845028874224;6267.4986001119805;6282.748690052346;6290.937090629127;6313.684315784192;4370.519242883281;4942.308076869242;4987.9525299687475;5025.170846810309;5035.9928014397265;4332.436783218224;4405.845795397146;4447.043885564619;4474.664400170001;4511.05267893746;5849.7952571660635;5902.970485147547;5916.467517923322;5922.733476993546;5931.911021334683;6248.968755156286;6268.655223962726;6307.5584709070845;6313.873722525524;6318.62088274705;5756.395578464285;5847.386024467455;5882.823515294548;5984.940150598525;5992.850178745479;5513.58648101394;5519.641223320552;5520.558355331564;5524.226608274845;5528.917066244009;6476.4495017924;6504.1219435375615;6522.641254731036;6525;6553.803385898431;6173.876522469615;6241.500679945684;6267.467265282502;6294.937050629435;6317.842053948688;6478.6436745977535;6518.054882042172;6522.15212022434;6534.444572211415;6537.378948999837;6166.321704612399;6289.213848268966;6302.086197501245;6304;6315.05274208854;6208.565400422108;6289.96855015722;6309.211348581427;6313.1477250572425;6316.715747791269;6230.719617617127;6269.968650156902;6276.372362763687;6281.59169653971;6294.968525157345;6095.1466794647895;6118.010103775157;6226.439620434183;6249.031400132987;6324.272708638566;6089.604175728564;6096.573239873166;6112.503480924647;6133.824358647991;6196.1015652731;6263.279722831932;6280.403361680633;6292.748290068346;6295.087212354091;6299.023651334051;6128.264608247039;6160.845978850564;6161.106639537332;6167.84580385476;6168.321484636776 12:38:20 INFO - PROCESS | 2003 | |1;ext.html;477.5415601023018;597.4772074434869;599.9280086389637;657.0932113683118;675.0178490296619;39717;40386.19227615446;40393;40468.39297410541;40503.59496405035;43442;44190;44195.77902110493;44215.55784442154;44310.33534496977;9679.370840895355;9908.256880733974;9910.653127140551;9920.45437500937;9940.850887236697;8244.340452763765;9832.557534910946;9843;9936.453495057769;9956.850647240297;8460.830783384328;9996.550155243032;9996.750081247954;10009.749756256115;10014.248931330143;9901.752456188617;9994.150497207746;9997.250206234561;9998.900010999869;10000.749981250417;9691.70924872248;9812.65655702047;9819.754506137333;9826.606935722562;9830.852537211947;42192.78903605462;42446.78776606128;42470.57529424728;42515.574844251474;42536.57463425388;3389.5254664347012;3491.965080349215;3524.9295014099575;3525.294941011808;3677.3196958562753;29341.413171736447;29379.853100734574;29755.404891902042;29806.85096574525;29863.25341866449;2346.2609278077352;2664.5203863304596;2798.748112669849;2825.834781266646;2921.357301393711;518845;522797;523271;523688;523916.38041809545;73554.2644573558;74005;74020.25979740241;74184.88722669164;74239.14402139881;77758.83361749578;78556;78699.8195027075;78728;79773.60113199397;18168.545786355182;18195.27218911255;18347.633047339245;18390.816091839177;18421.171047302905;13870.167789932637;13942.302884855919;13990.440382384793;13993.230372329619;13996.16023038621;19491.53813463996;20457.07943142562;20492.38522844317;22141.335759927228;22806.201782937518;9462.952685236529;9625.278104142217;9653.46905920181;9686.564104615309;9693.369930954465;1027.2655051638114;1041.6979076067855;1056.4717641179411;1072.9409882456384;1140.7205234717546;23912.641310380357;26785.866070669523;30072.548911766342;30624.69375306263;30678.238958493843;820.6102101501858;1096.8245080787196;1099.961501347449;1221.4930803716536;1227.128738595607;14333.354999025069;14676.926615367069;15065.849341506664;15120.39518419251;15150.015249008778;553907;554557;563263;563484;564603;61537.69231153816;62005.37994620086;62060.68969655123;62173.37826621766;62198.378016219256;1390.5828251524501;1522.8324884262722;1540.4300408848574;1554.65020370418;1563.4215340323926;24168.51662966766;29290.681919313254;30285.394292114474;30347;31009;48584.757076214395;48746.75626621844;49097.50902490929;49118.508814911394;49121.50878491169;329271;331712;331727.34136330127;422485;490075;44793.77603111963;47124.52875471202;47246;47672;47764;47939.520604793506;48168.75915620539;49672.751636241584;49987.75006124946;50895;39143.60856391399;39883.2023359537;41850;42257.366139508544;43270.48553300619;36470;37809.62190378061;41664.95837604084;41877;41978.37032444455;40979.795101024305;41105.38341924814;42609.786951066286;42779.786101069294;42939.570604293556;35729.28541429105;35832;36643.45034824533;36658;36728;26760.866195668896;26943.326416839736;27198.592021119304;27223.319417014733;27572.448551028465 12:38:20 INFO - PROCESS | 2003 | |2;jquery.html;378.3473508198358;381.61647544218073;381.9847206111756;384.4694321835866;386.1273521840639;19960.900195499038;20492;21111.788882111174;21390.465238369048;21399.57200855984;12058.879411205886;12459;12575.748485030294;12580.433880475377;12593.748125037493;5061.544460998519;5995.940040599582;6172.629642221481;6190.288116866551;6190.3190649028575;6102.827788989334;6123.877522449548;6145.846353841145;6153.384661533855;6178.62928224308;5864.296284445851;6043.395660433944;6044.4257795509575;6050.969745151268;6051.969740151293;5640.182173584848;5998.190244317027;6023.518118550505;6025.758969641231;6029.638221706711;5164.2253661950635;5295.364556253236;5320.654157479751;5322.0686379883755;5336.626436149471;13633.386497607631;14038.85961140396;14156.009079364449;14341.713165736732;14392.496262630862;1988.5128143604766;2193;2196.626573482512;2225.265662331427;2292.060255295338;7705.61471926407;9803;13525.526606568723;14427.71144577113;14959.925200374037;1677.7986641603086;1730.1176400036072;1785.9017754023523;1825.516238196879;1847.2610955617727;91238;108935.99999999921;109164;111180;112428.87571124265;11975.101867359983;11983;12020.699482512833;12028.45871935765;12070.577529786415;14491.78262326066;14576.125432474086;14582.41670333196;14615.853841461661;14618.85381146175;9112.179903808688;9157.908420915839;9169;9178.128077832594;9269.536523173949;9405.717828465156;9411.200047995997;9427.292953028551;9500.47747373901;9504.811898512686;4618.468876079294;4708.505606911225;4712.151812673752;4754.429468463806;4771.5228477152;1933.941981740522;1939.6702560564738;1945.114972687452;1962.5093726568357;1988.6917527783216;410.2308172177168;446.8168051099034;462.06662541666316;469.13678830951216;896.6996056321206;11834.704132396759;11862.332199257577;12030.518779248732;12230.082743794252;12360.567380141652;462.79174371532946;478.5214785214785;485.02267930120837;489.22702130633513;499.47804544251346;5100.872478188075;6328.46208072319;6331.715072821734;6379.425851673372;6446.033095035688;573911;573974;634863;673087;708477;98483.50758246164;124873;125934;126204.36897815453;130600.34699826631;1037.123630532214;1049.6903413493037;1075.0593230922943;1078.8435676826816;1082.5182793656904;17178.453939145536;18560.535986600444;18820.15309311057;19388.515287117934;19757.50606234798;42921.283148673705;47273.527264726916;47307.763461182476;49346.50653493419;51014.48985510246;55440.891182176936;62966.685166575706;66770.33229667836;66929.33070669425;67096.32259193559;7998.800029999296;8065.55639439813;8141.877871831809;8183.140770219279;8354.248117669196;12862.356882156042;13050.934745326213;13165.407556660164;13397;13556.864431355954;8909.866352004854;11778.234414763014;11825.822612660644;11973.042156627624;12036.976856967256;11508.079353651856;11620.6513804586;11671.708207294885;11746.353950532803;11840.585579504675;6117.327094019565;11918;11948.880511194777;12028;12093.911547960726;8068.193180681885;8116.959415202886;8312.584370781558;8503.91496085056;8518.23335899772;8928.821423571622;11450.427478626201;11726.237794543327;11885.702857428634;12090.126030465291 12:38:20 INFO - PROCESS | 2003 | |3;mootools.html;1508.358947447336;1642.228152768199;1671.2897018767026;2017.243533674872;2094.6439105352097;8313.542755148464;8922.643094276229;9094.226990705782;9101.408408453446;9120.452772833627;8792.736217913456;9027.961784394796;9053.864192037125;9056.366054376196;9074.637014519429;2281.041962375798;2502.06172685243;2560.283120726195;2575.896964121433;2587.379029033028;2605.3747100695887;2616.9214923552227;2617.450335429562;2621.6067589861577;2632.197179860142;2503.1364179358184;2567.704713957891;2571.8842652080702;2575.90984315549;2576.4203054312816;2427.4295540547955;2448.069733501267;2496.3883848457062;2510.0085466240826;2511.1085564624477;2214.568159208955;2538.352720056392;2586.5602847515966;2599.9480010399875;2613.973860261392;9297.4886381249;9343.486108264044;9414.95292523533;9426.811463770686;9434.433933963915;5742.598018138732;5829.125631155318;5881.764729410818;5894.675792831393;5899.793507227269;3700.2414505026404;3781.243751249761;3847.7306588538813;3861.5559210690567;3867.941980870289;1080.168270431771;1083.7615724540667;1085.636311835536;1109.8335249712527;1136.0343707848344;12732.363381830872;12745.681357966032;12752.617421477464;12762.106652534327;12772.744545109139;5119.6416250862085;5131.7690703918415;5244.501772331622;5247.317848679723;5252.763625636855;10762.515686794113;10812.297200681931;10824.72938176536;10843.51204195813;10849.349039057524;5777.595568310262;5827.368336865685;5831;5835.891180675658;5840.386759390288;4607.14767767964;4776.355192049098;5067.721275329818;5111.463296353903;5175.482451754794;4147.937780933288;4214.768187749642;4234.745915245096;4257.87226383209;4266.701330906807;1348.4673553946136;1352.0805852020524;1355.241065003601;1364.7952807079018;1367.924764137962;1403.0389183409397;1410.0341266232663;1442.4302400551933;1452.6658868460102;1473.7789331600345;8596.097409772008;8757.956210219036;8767.167119123673;8778.166074222938;8778.736637900873;521.3691433365594;528.5692160888864;536.9946300537023;537.8037016489031;541.2098336428858;6427.421532062137;6435.03474478832;6484.319146489645;6497.870042599122;6500.837479063061;11025;11370.658880233606;11384.886151138548;11401.714957126138;11418.600348987911;10577.31247468912;10912.454377281105;11093.445327733742;11157.163212758913;11230.438478076227;8573.22840944318;8610.96668399796;8660.393772435995;8722.476651400937;8758.386912916161;8446.324294056583;8450.661973521237;8489.193526614961;8546.743597692079;8577.785555361166;9732.854007189757;9770.218382529523;9869.358491698016;9909.207263418764;10009.299349045497;10157.9492102539;10463.162946964378;10512;10602.628907988183;10762.46187690628;7162.749303774552;7342.412606991321;7650.846983060419;7720.7683769487;7996.600169991593;8695.956520217358;8758.91241087581;8765.649374024968;8769.166929141722;8770.824583508422;7604.12552556441;7678.923210767821;7754.844903102019;7833.1383547808555;7853.175416581176;7561.130469996021;7596.240375962359;7615.6953721850505;7732.961335193288;7775.961120194363;8055.718049868226;8227;8231.34149268069;8241.629126689433;8264.545450000067;7241.167265764505;7451.515651482637;7463.2163622818825;7472.813179670552;7488.138864030489;7500.549967001997;7562.773116806505;7583.469157158946;7598.354139898171;7610.809729756579 12:38:20 INFO - PROCESS | 2003 | |4;prototype.html;332.8252667349641;337.79056984669506;340.8057407277851;341.27308832187435;347.92519608284215;6617.371349721769;6663.600183988958;6677.799666010022;6723.899141512875;6834.248232694412;5859.970700146504;5930.258717660293;6369.140166077578;6691.3977742003335;6702.530822842403;4765.928511072337;4809.615230781546;4906.975465122669;4927.507249275061;5014.674046187004;4888.951110488885;4906.901861962759;4916.901661966758;4918.680285781431;4919.877003074916;4897.191963326047;4917.385326834145;4918.508149185089;4919.942212424328;4926.236433352836;3988.960110398917;4732.361131247289;4806.966502202026;4918.385201849769;4931.80272789088;4219.071804203101;4231.132617813341;4232.809523571446;4244.554321796198;4257.97871010646;6322.936770632281;6404.263509696398;6408;6447;6453.354664533556;5930.495907847838;5947.5539334550085;5948.13752005961;5950.7917222896995;5951.137085122633;6802.557833740791;7151.74968876092;7152.213256541776;7155.3560179583565;7166.3908567771805;4642.396488456479;4667.813287468497;4693.507181745902;4702.623790096784;4709.034647897173;6565.967170164118;7115.786526404217;7447;7531.849363012764;7538.698452061911;3877.2245550889934;3924.274009308287;4707.152712511781;4716.410448693913;4731.810727570859;4793.32893394925;4808.158572249842;4810.6632535722165;4812.663113582015;4832.081904438145;4678.578927896506;5756.02147634903;5774.105013722879;5786.623869448473;5793.015187418149;6842.384185423336;7116.71533138679;7121;7151.53515021522;7165.104361954755;1641.9014859108493;1676.639522502668;1678.0602862397097;1678.991605041967;1679.1772031704377;1019.90820826126;1065.1265961911313;1068.7167900506372;1073.1897417449775;1101.2071308657753;6586.176727909012;6596.010598410181;6651.600903945682;6665.966670166618;6704.7988560343265;7372.447066469929;7373.446991475661;7384.1877393486675;7407.2222416646555;7423.294786995227;5456.972715136479;6633.336666333425;6635.402813746786;6636.838553253161;6639;3859.8070096495626;3906.374980003186;3907.785071821077;3911.471951286597;3918.9216215676097;7461.962690186514;7720.922790772132;7722.42081843864;7731.7680469586;7741.148473667892;7647.847043059108;7707.807304817312;7729.652165652559;7736.7292144774665;7737.0715514138665;7811.140774514799;7827.25641064098;7840.215978402114;7843.803904902423;7852.960735196288;7085.383098647702;7443.4789564729945;7450.478466507292;7451.40388768908;7482.139553951365;7291.08861392326;7316.561006339423;7321.487495875238;7332.486725929347;7349;7735.419843511647;7748.34139098183;7758.456908016385;7762.184970578008;7778.883316750366;4687.624990000723;4727.267273572465;4736.313234581035;4744.4543877454535;4745.738984355894;7116.750913717995;7407.333339999211;7423.777286681408;7424.480286379901;7447.329740323397;5160.741962901765;7133.714651413885;7175.8564828704175;7175.8564828704175;7178.28217178278;5930.673812940329;7087.610181439864;7145.46409019336;7154.35610795031;7171.139463264233;5770.451807078321;6984.930150698428;7012.298770122947;7019.2629773873;7029.5430796998035;6665;6870.7595234166565;7155.356017958408;7166.355028047501;7183.568985860865;6734.326567343226;6934.549254298455;6936.237013928363;6944.201416836926;7008.789736307919 12:38:20 INFO - PROCESS | 2003 | |5;yui.html;638.7958697854543;712.9857402851942;724.7825652304307;742.918278989311;780.274344859281;14369.35337909794;15399.692006159885;15401.845981540182;15406.92151549392;15462.458813941486;13212.933935330333;14353.28233588319;14427;14435.566932992;14449.711005779878;794.940379471539;992.5831150916596;1014.8376259798433;1015.8273093574073;1017.8015287019034;991.0535438656102;999.3454287441701;1007.6271779441616;1010.7372083258332;1011.1051719228499;839.5424493650944;855.1277696749312;1064.5369264369986;1069.1660504806264;1074.0548317480645;1042.7236782252671;1066.9413182274973;1070.411273799415;1071.314358810362;1073.50618715391;789.5381201996839;789.9921000789976;791.0349373763999;795.2167115391335;799.0571126071234;14939.775903361458;14995.400183992628;15002.849971500364;15018.399264029425;15042.247887605576;11794.882051179464;12963.870361296455;12993.805092923614;13217.273049982246;13372.933135334359;10169.59321627134;10480.266381353309;11159.609413670563;11193.44032798365;11761.705957351049;3456.2914602506676;3528.311979164064;3566.35805555;3607.3687104756564;3648.543932008499;90982;92997;93039;93202.5339873303;93292.53353733255;9334.71995840126;9719.271054670928;9770.92519822819;9929.851052234222;10206.23453240995;21950.231741889278;22003.009864556134;22072.668909966364;22079.33761987143;22275.77724222737;7513.32380085784;7630.38956883448;7787.922120778833;7800.45396822217;7866.685332586747;3815;3989.7207195496035;4020.3567429211184;4041.8787436376956;4078.1232035112594;3589.9820500897326;3619.49327094207;3623.474596183539;3623.8550457981387;3630.074331045619;610.2341561340489;623.9500839932795;657.3656421553128;706.2231545300128;731.377692980359;567.5743192605546;570.37543889441;598.3149294058279;624.7875722254364;632.5635311634957;8174.877376839352;8589.871151932726;8590.828183436297;8594.35542334315;8613.913860861312;541.7318427378473;582.4263100845664;597.4324391827694;604.3684349854412;634.8984162533973;3968.0675041365257;4035.2534781065597;4138.544760076389;4253.723507971972;4289.142171565637;86906.56546717226;89159.55420222858;92100;92958;93880.0611993885;41700.582994170276;49928;65125.04624861262;74575;77206;68695;69021.999999999;69025.65487172632;69392;69482.30517694859;8600.13998600135;8645.913540864762;8646.481211127353;8804.471731695863;8822.95588522079;45620.315695265264;46153.30770038385;46848.765756171;46974.82562935817;47032;45752.771236143606;52832.73583632057;55077.72461137669;61863.6906815463;61934.690326549884;11113.277636953571;11226.494807733508;11307.265027773497;11624.709382265512;11845.644630661094;11920.688007644363;12091.029252330378;12122.636320910387;12220.877791221974;12367.319797411228;11197.888021119685;11553.24903881245;11597.420128993348;11806.232594881305;12009.699757506132;12066.698332541757;12106.334151621746;12120.878791211975;12214.694632634255;12217.572384966483;11792.646220613395;11816.645500634995;11894;11948.462319195483;12104.75790484203;9768.560414781494;9871.160951319218;9890.752731181778;9993.350432221881;10152.03555662211;9595.22633498468;9640.897409182391;9713.36863103896;9752.707418777449;9995.400275983464 12:38:20 INFO - PROCESS | 2003 | __end_tp_report 12:38:20 INFO - PROCESS | 2003 | __start_cc_report 12:38:20 INFO - PROCESS | 2003 | _x_x_mozilla_cycle_collect,1146 12:38:20 INFO - PROCESS | 2003 | __end_cc_report 12:38:20 INFO - PROCESS | 2003 | __startTimestamp1458070700569__endTimestamp 12:38:20 INFO - PROCESS | 2003 | 12:38:20 INFO - PROCESS | 2003 | ------- Summary: start ------- 12:38:20 INFO - PROCESS | 2003 | Number of tests: 6 12:38:20 INFO - PROCESS | 2003 | 12:38:20 INFO - PROCESS | 2003 | [#0] dojo.html Cycles:165 Average:5873.50 Median:6133.82 stddev:640.82 (10.4%) stddev-sans-first:613.86 12:38:20 INFO - PROCESS | 2003 | Values: 3447.1 3512.3 3513.7 3562.4 3600.4 5917.2 5943.5 5962.9 5965.4 5975.4 5933.1 5982.5 5989.7 5992.3 5998.1 5180.9 5272.0 5284.3 5348.1 5396.5 5297.8 5378.1 5395.6 5416.2 5417.3 5394.0 5416.8 5422.4 5423.3 5436.8 5368.5 5384.6 5392.8 5399.2 5470.5 5149.3 5204.9 5321.3 5324.4 5340.1 5748.7 5758.8 5839.5 5849.4 5874.9 6184.0 6254.5 6263.9 6275.5 6277.4 5946.8 6199.9 6222.1 6284.7 6319.5 5993.7 6073.1 6085.7 6105.5 6125.6 6380.4 6390.6 6394.1 6397.7 6407.0 6174.6 6228.6 6266.2 6307.8 6312.9 6272.1 6274.8 6275.6 6295.4 6308.6 6210.8 6213.7 6242.2 6261.0 6265.1 6198.8 6267.5 6282.7 6290.9 6313.7 4370.5 4942.3 4988.0 5025.2 5036.0 4332.4 4405.8 4447.0 4474.7 4511.1 5849.8 5903.0 5916.5 5922.7 5931.9 6249.0 6268.7 6307.6 6313.9 6318.6 5756.4 5847.4 5882.8 5984.9 5992.9 5513.6 5519.6 5520.6 5524.2 5528.9 6476.4 6504.1 6522.6 6525.0 6553.8 6173.9 6241.5 6267.5 6294.9 6317.8 6478.6 6518.1 6522.2 6534.4 6537.4 6166.3 6289.2 6302.1 6304.0 6315.1 6208.6 6290.0 6309.2 6313.1 6316.7 6230.7 6270.0 6276.4 6281.6 6295.0 6095.1 6118.0 6226.4 6249.0 6324.3 6089.6 6096.6 6112.5 6133.8 6196.1 6263.3 6280.4 6292.7 6295.1 6299.0 6128.3 6160.8 6161.1 6167.8 6168.3 12:38:20 INFO - PROCESS | 2003 | 12:38:20 INFO - PROCESS | 2003 | [#1] ext.html Cycles:180 Average:65591.62 Median:232338.89 stddev:131655.62 (56.7%) stddev-sans-first:131934.18 12:38:20 INFO - PROCESS | 2003 | Values: 477.5 597.5 599.9 657.1 675.0 39717.0 40386.2 40393.0 40468.4 40503.6 43442.0 44190.0 44195.8 44215.6 44310.3 9679.4 9908.3 9910.7 9920.5 9940.9 8244.3 9832.6 9843.0 9936.5 9956.9 8460.8 9996.6 9996.8 10009.7 10014.2 9901.8 9994.2 9997.3 9998.9 10000.7 9691.7 9812.7 9819.8 9826.6 9830.9 42192.8 42446.8 42470.6 42515.6 42536.6 3389.5 3492.0 3524.9 3525.3 3677.3 29341.4 29379.9 29755.4 29806.9 29863.3 2346.3 2664.5 2798.7 2825.8 2921.4 518845.0 522797.0 523271.0 523688.0 523916.4 73554.3 74005.0 74020.3 74184.9 74239.1 77758.8 78556.0 78699.8 78728.0 79773.6 18168.5 18195.3 18347.6 18390.8 18421.2 13870.2 13942.3 13990.4 13993.2 13996.2 19491.5 20457.1 20492.4 22141.3 22806.2 9463.0 9625.3 9653.5 9686.6 9693.4 1027.3 1041.7 1056.5 1072.9 1140.7 23912.6 26785.9 30072.5 30624.7 30678.2 820.6 1096.8 1100.0 1221.5 1227.1 14333.4 14676.9 15065.8 15120.4 15150.0 553907.0 554557.0 563263.0 563484.0 564603.0 61537.7 62005.4 62060.7 62173.4 62198.4 1390.6 1522.8 1540.4 1554.7 1563.4 24168.5 29290.7 30285.4 30347.0 31009.0 48584.8 48746.8 49097.5 49118.5 49121.5 329271.0 331712.0 331727.3 422485.0 490075.0 44793.8 47124.5 47246.0 47672.0 47764.0 47939.5 48168.8 49672.8 49987.8 50895.0 39143.6 39883.2 41850.0 42257.4 43270.5 36470.0 37809.6 41665.0 41877.0 41978.4 40979.8 41105.4 42609.8 42779.8 42939.6 35729.3 35832.0 36643.5 36658.0 36728.0 26760.9 26943.3 27198.6 27223.3 27572.4 12:38:20 INFO - PROCESS | 2003 | 12:38:20 INFO - PROCESS | 2003 | [#2] jquery.html Cycles:180 Average:34189.40 Median:383.23 stddev:105299.40 (27477.0%) stddev-sans-first:105564.19 12:38:20 INFO - PROCESS | 2003 | Values: 378.3 381.6 382.0 384.5 386.1 19960.9 20492.0 21111.8 21390.5 21399.6 12058.9 12459.0 12575.7 12580.4 12593.7 5061.5 5995.9 6172.6 6190.3 6190.3 6102.8 6123.9 6145.8 6153.4 6178.6 5864.3 6043.4 6044.4 6051.0 6052.0 5640.2 5998.2 6023.5 6025.8 6029.6 5164.2 5295.4 5320.7 5322.1 5336.6 13633.4 14038.9 14156.0 14341.7 14392.5 1988.5 2193.0 2196.6 2225.3 2292.1 7705.6 9803.0 13525.5 14427.7 14959.9 1677.8 1730.1 1785.9 1825.5 1847.3 91238.0 108936.0 109164.0 111180.0 112428.9 11975.1 11983.0 12020.7 12028.5 12070.6 14491.8 14576.1 14582.4 14615.9 14618.9 9112.2 9157.9 9169.0 9178.1 9269.5 9405.7 9411.2 9427.3 9500.5 9504.8 4618.5 4708.5 4712.2 4754.4 4771.5 1933.9 1939.7 1945.1 1962.5 1988.7 410.2 446.8 462.1 469.1 896.7 11834.7 11862.3 12030.5 12230.1 12360.6 462.8 478.5 485.0 489.2 499.5 5100.9 6328.5 6331.7 6379.4 6446.0 573911.0 573974.0 634863.0 673087.0 708477.0 98483.5 124873.0 125934.0 126204.4 130600.3 1037.1 1049.7 1075.1 1078.8 1082.5 17178.5 18560.5 18820.2 19388.5 19757.5 42921.3 47273.5 47307.8 49346.5 51014.5 55440.9 62966.7 66770.3 66929.3 67096.3 7998.8 8065.6 8141.9 8183.1 8354.2 12862.4 13050.9 13165.4 13397.0 13556.9 8909.9 11778.2 11825.8 11973.0 12037.0 11508.1 11620.7 11671.7 11746.4 11840.6 6117.3 11918.0 11948.9 12028.0 12093.9 8068.2 8117.0 8312.6 8503.9 8518.2 8928.8 11450.4 11726.2 11885.7 12090.1 12:38:20 INFO - PROCESS | 2003 | 12:38:20 INFO - PROCESS | 2003 | [#3] mootools.html Cycles:180 Average:6377.05 Median:5250.04 stddev:3390.98 (64.6%) stddev-sans-first:3380.74 12:38:20 INFO - PROCESS | 2003 | Values: 1508.4 1642.2 1671.3 2017.2 2094.6 8313.5 8922.6 9094.2 9101.4 9120.5 8792.7 9028.0 9053.9 9056.4 9074.6 2281.0 2502.1 2560.3 2575.9 2587.4 2605.4 2616.9 2617.5 2621.6 2632.2 2503.1 2567.7 2571.9 2575.9 2576.4 2427.4 2448.1 2496.4 2510.0 2511.1 2214.6 2538.4 2586.6 2599.9 2614.0 9297.5 9343.5 9415.0 9426.8 9434.4 5742.6 5829.1 5881.8 5894.7 5899.8 3700.2 3781.2 3847.7 3861.6 3867.9 1080.2 1083.8 1085.6 1109.8 1136.0 12732.4 12745.7 12752.6 12762.1 12772.7 5119.6 5131.8 5244.5 5247.3 5252.8 10762.5 10812.3 10824.7 10843.5 10849.3 5777.6 5827.4 5831.0 5835.9 5840.4 4607.1 4776.4 5067.7 5111.5 5175.5 4147.9 4214.8 4234.7 4257.9 4266.7 1348.5 1352.1 1355.2 1364.8 1367.9 1403.0 1410.0 1442.4 1452.7 1473.8 8596.1 8758.0 8767.2 8778.2 8778.7 521.4 528.6 537.0 537.8 541.2 6427.4 6435.0 6484.3 6497.9 6500.8 11025.0 11370.7 11384.9 11401.7 11418.6 10577.3 10912.5 11093.4 11157.2 11230.4 8573.2 8611.0 8660.4 8722.5 8758.4 8446.3 8450.7 8489.2 8546.7 8577.8 9732.9 9770.2 9869.4 9909.2 10009.3 10157.9 10463.2 10512.0 10602.6 10762.5 7162.7 7342.4 7650.8 7720.8 7996.6 8696.0 8758.9 8765.6 8769.2 8770.8 7604.1 7678.9 7754.8 7833.1 7853.2 7561.1 7596.2 7615.7 7733.0 7776.0 8055.7 8227.0 8231.3 8241.6 8264.5 7241.2 7451.5 7463.2 7472.8 7488.1 7500.5 7562.8 7583.5 7598.4 7610.8 12:38:20 INFO - PROCESS | 2003 | 12:38:20 INFO - PROCESS | 2003 | [#4] prototype.html Cycles:180 Average:5815.89 Median:6625.35 stddev:1870.51 (28.2%) stddev-sans-first:1829.92 12:38:20 INFO - PROCESS | 2003 | Values: 332.8 337.8 340.8 341.3 347.9 6617.4 6663.6 6677.8 6723.9 6834.2 5860.0 5930.3 6369.1 6691.4 6702.5 4765.9 4809.6 4907.0 4927.5 5014.7 4889.0 4906.9 4916.9 4918.7 4919.9 4897.2 4917.4 4918.5 4919.9 4926.2 3989.0 4732.4 4807.0 4918.4 4931.8 4219.1 4231.1 4232.8 4244.6 4258.0 6322.9 6404.3 6408.0 6447.0 6453.4 5930.5 5947.6 5948.1 5950.8 5951.1 6802.6 7151.7 7152.2 7155.4 7166.4 4642.4 4667.8 4693.5 4702.6 4709.0 6566.0 7115.8 7447.0 7531.8 7538.7 3877.2 3924.3 4707.2 4716.4 4731.8 4793.3 4808.2 4810.7 4812.7 4832.1 4678.6 5756.0 5774.1 5786.6 5793.0 6842.4 7116.7 7121.0 7151.5 7165.1 1641.9 1676.6 1678.1 1679.0 1679.2 1019.9 1065.1 1068.7 1073.2 1101.2 6586.2 6596.0 6651.6 6666.0 6704.8 7372.4 7373.4 7384.2 7407.2 7423.3 5457.0 6633.3 6635.4 6636.8 6639.0 3859.8 3906.4 3907.8 3911.5 3918.9 7462.0 7720.9 7722.4 7731.8 7741.1 7647.8 7707.8 7729.7 7736.7 7737.1 7811.1 7827.3 7840.2 7843.8 7853.0 7085.4 7443.5 7450.5 7451.4 7482.1 7291.1 7316.6 7321.5 7332.5 7349.0 7735.4 7748.3 7758.5 7762.2 7778.9 4687.6 4727.3 4736.3 4744.5 4745.7 7116.8 7407.3 7423.8 7424.5 7447.3 5160.7 7133.7 7175.9 7175.9 7178.3 5930.7 7087.6 7145.5 7154.4 7171.1 5770.5 6984.9 7012.3 7019.3 7029.5 6665.0 6870.8 7155.4 7166.4 7183.6 6734.3 6934.5 6936.2 6944.2 7008.8 12:38:20 INFO - PROCESS | 2003 | 12:38:20 INFO - PROCESS | 2003 | [#5] yui.html Cycles:180 Average:17866.25 Median:4271.43 stddev:24871.82 (582.3%) stddev-sans-first:24907.96 12:38:20 INFO - PROCESS | 2003 | Values: 638.8 713.0 724.8 742.9 780.3 14369.4 15399.7 15401.8 15406.9 15462.5 13212.9 14353.3 14427.0 14435.6 14449.7 794.9 992.6 1014.8 1015.8 1017.8 991.1 999.3 1007.6 1010.7 1011.1 839.5 855.1 1064.5 1069.2 1074.1 1042.7 1066.9 1070.4 1071.3 1073.5 789.5 790.0 791.0 795.2 799.1 14939.8 14995.4 15002.8 15018.4 15042.2 11794.9 12963.9 12993.8 13217.3 13372.9 10169.6 10480.3 11159.6 11193.4 11761.7 3456.3 3528.3 3566.4 3607.4 3648.5 90982.0 92997.0 93039.0 93202.5 93292.5 9334.7 9719.3 9770.9 9929.9 10206.2 21950.2 22003.0 22072.7 22079.3 22275.8 7513.3 7630.4 7787.9 7800.5 7866.7 3815.0 3989.7 4020.4 4041.9 4078.1 3590.0 3619.5 3623.5 3623.9 3630.1 610.2 624.0 657.4 706.2 731.4 567.6 570.4 598.3 624.8 632.6 8174.9 8589.9 8590.8 8594.4 8613.9 541.7 582.4 597.4 604.4 634.9 3968.1 4035.3 4138.5 4253.7 4289.1 86906.6 89159.6 92100.0 92958.0 93880.1 41700.6 49928.0 65125.0 74575.0 77206.0 68695.0 69022.0 69025.7 69392.0 69482.3 8600.1 8645.9 8646.5 8804.5 8823.0 45620.3 46153.3 46848.8 46974.8 47032.0 45752.8 52832.7 55077.7 61863.7 61934.7 11113.3 11226.5 11307.3 11624.7 11845.6 11920.7 12091.0 12122.6 12220.9 12367.3 11197.9 11553.2 11597.4 11806.2 12009.7 12066.7 12106.3 12120.9 12214.7 12217.6 11792.6 11816.6 11894.0 11948.5 12104.8 9768.6 9871.2 9890.8 9993.4 10152.0 9595.2 9640.9 9713.4 9752.7 9995.4 12:38:20 INFO - PROCESS | 2003 | -------- Summary: end -------- 12:38:20 INFO - PROCESS | 2003 | 12:38:21 INFO - TEST-INFO | 2003: exit 0 12:38:21 INFO - TEST-OK | dromaeo_css | took 1114286ms 12:38:21 INFO - TEST-START | kraken 12:38:21 INFO - operating with platform_type : mac_ 12:38:21 INFO - Initialising browser for kraken test... 12:38:21 INFO - TEST-INFO | started process 2007 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/tmpZEQsbm/profile http://localhost:49392/getInfo.html) 12:38:23 INFO - PROCESS | 2007 | __metrics Screen width/height:1600/1200 12:38:23 INFO - PROCESS | 2007 | colorDepth:24 12:38:23 INFO - PROCESS | 2007 | Browser inner width/height: 1024/689 12:38:23 INFO - PROCESS | 2007 | __metrics 12:38:23 INFO - PROCESS | 2007 | 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" 12:38:23 INFO - PROCESS | 2007 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:38:24 INFO - TEST-INFO | 2007: exit 0 12:38:24 INFO - Browser initialized. 12:38:24 INFO - Running cycle 1/1 for kraken test... 12:38:24 INFO - TEST-INFO | started process 2009 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/tmpZEQsbm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:38:36 INFO - PROCESS | 2009 | RSS: Main: 209281024 12:38:36 INFO - PROCESS | 2009 | 12:38:38 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49392/tests/kraken/driver.html?testName=audio-beat-detection) 12:38:39 INFO - PROCESS | 2009 | RSS: Main: 264486912 12:38:39 INFO - PROCESS | 2009 | 12:38:41 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49392/tests/kraken/driver.html?testName=audio-dft) 12:38:42 INFO - PROCESS | 2009 | RSS: Main: 275255296 12:38:42 INFO - PROCESS | 2009 | 12:38:45 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49392/tests/kraken/driver.html?testName=audio-fft) 12:38:46 INFO - PROCESS | 2009 | RSS: Main: 264351744 12:38:46 INFO - PROCESS | 2009 | 12:38:48 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49392/tests/kraken/driver.html?testName=audio-oscillator) 12:38:48 INFO - PROCESS | 2009 | RSS: Main: 267210752 12:38:48 INFO - PROCESS | 2009 | 12:38:50 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49392/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:38:51 INFO - PROCESS | 2009 | RSS: Main: 265814016 12:38:51 INFO - PROCESS | 2009 | 12:38:54 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49392/tests/kraken/driver.html?testName=imaging-darkroom) 12:38:54 INFO - PROCESS | 2009 | RSS: Main: 267788288 12:38:54 INFO - PROCESS | 2009 | 12:38:57 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49392/tests/kraken/driver.html?testName=imaging-desaturate) 12:38:58 INFO - PROCESS | 2009 | RSS: Main: 267239424 12:38:58 INFO - PROCESS | 2009 | 12:39:00 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49392/tests/kraken/driver.html?testName=json-parse-financial) 12:39:01 INFO - PROCESS | 2009 | RSS: Main: 268079104 12:39:01 INFO - PROCESS | 2009 | 12:39:03 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49392/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:39:03 INFO - PROCESS | 2009 | RSS: Main: 302239744 12:39:03 INFO - PROCESS | 2009 | 12:39:05 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:39:06 INFO - PROCESS | 2009 | RSS: Main: 302772224 12:39:06 INFO - PROCESS | 2009 | 12:39:08 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:39:08 INFO - PROCESS | 2009 | RSS: Main: 308203520 12:39:08 INFO - PROCESS | 2009 | 12:39:11 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:39:11 INFO - PROCESS | 2009 | RSS: Main: 309583872 12:39:11 INFO - PROCESS | 2009 | 12:39:14 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:39:14 INFO - PROCESS | 2009 | RSS: Main: 310247424 12:39:14 INFO - PROCESS | 2009 | 12:39:16 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49392/tests/kraken/driver.html?testName=ai-astar) 12:39:16 INFO - PROCESS | 2009 | RSS: Main: 369618944 12:39:16 INFO - PROCESS | 2009 | 12:39:16 INFO - PROCESS | 2009 | __start_tp_report 12:39:16 INFO - PROCESS | 2009 | _x_x_mozilla_page_load 12:39:16 INFO - PROCESS | 2009 | _x_x_mozilla_page_load_details 12:39:16 INFO - PROCESS | 2009 | |i|pagename|runs| 12:39:16 INFO - PROCESS | 2009 | |0;ai-astar;112;110;111;110;112;110;117;110;110;110 12:39:16 INFO - PROCESS | 2009 | |1;audio-beat-detection;153;120;154;146;116;139;116;149;146;115 12:39:16 INFO - PROCESS | 2009 | |2;audio-dft;183;186;185;188;184;187;185;186;188;260 12:39:16 INFO - PROCESS | 2009 | |3;audio-fft;74;74;75;122;69;74;83;83;134;55 12:39:16 INFO - PROCESS | 2009 | |4;audio-oscillator;93;96;135;80;76;85;119;76;80;119 12:39:16 INFO - PROCESS | 2009 | |5;imaging-gaussian-blur;89;88;88;88;89;78;133;124;90;86 12:39:16 INFO - PROCESS | 2009 | |6;imaging-darkroom;94;95;94;94;94;95;94;95;94;94 12:39:16 INFO - PROCESS | 2009 | |7;imaging-desaturate;87;84;83;84;85;86;86;84;86;85 12:39:16 INFO - PROCESS | 2009 | |8;json-parse-financial;56;58;58;56;57;57;58;67;51;49 12:39:16 INFO - PROCESS | 2009 | |9;json-stringify-tinderbox;64;69;62;74;82;101;98;87;66;67 12:39:16 INFO - PROCESS | 2009 | |10;stanford-crypto-aes;79;80;78;79;79;79;78;78;79;84 12:39:16 INFO - PROCESS | 2009 | |11;stanford-crypto-ccm;116;118;121;125;120;112;117;119;126;116 12:39:16 INFO - PROCESS | 2009 | |12;stanford-crypto-pbkdf2;134;156;165;127;134;119;133;130;131;131 12:39:16 INFO - PROCESS | 2009 | |13;stanford-crypto-sha256-iterative;65;67;66;65;65;65;65;65;65;64 12:39:16 INFO - PROCESS | 2009 | __end_tp_report 12:39:16 INFO - PROCESS | 2009 | __start_cc_report 12:39:16 INFO - PROCESS | 2009 | _x_x_mozilla_cycle_collect,1202 12:39:16 INFO - PROCESS | 2009 | __end_cc_report 12:39:16 INFO - PROCESS | 2009 | __startTimestamp1458070756885__endTimestamp 12:39:16 INFO - PROCESS | 2009 | 12:39:16 INFO - PROCESS | 2009 | ------- Summary: start ------- 12:39:16 INFO - PROCESS | 2009 | Number of tests: 14 12:39:16 INFO - PROCESS | 2009 | 12:39:16 INFO - PROCESS | 2009 | [#0] ai-astar Cycles:10 Average:111.20 Median:110.50 stddev:2.20 (2.0%) stddev-sans-first:2.32 12:39:16 INFO - PROCESS | 2009 | Values: 112.0 110.0 111.0 110.0 112.0 110.0 117.0 110.0 110.0 110.0 12:39:16 INFO - PROCESS | 2009 | 12:39:16 INFO - PROCESS | 2009 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:146.00 stddev:16.61 (11.4%) stddev-sans-first:16.36 12:39:16 INFO - PROCESS | 2009 | Values: 153.0 120.0 154.0 146.0 116.0 139.0 116.0 149.0 146.0 115.0 12:39:16 INFO - PROCESS | 2009 | 12:39:16 INFO - PROCESS | 2009 | [#2] audio-dft Cycles:10 Average:193.20 Median:186.50 stddev:23.53 (12.6%) stddev-sans-first:24.66 12:39:16 INFO - PROCESS | 2009 | Values: 183.0 186.0 185.0 188.0 184.0 187.0 185.0 186.0 188.0 260.0 12:39:16 INFO - PROCESS | 2009 | 12:39:16 INFO - PROCESS | 2009 | [#3] audio-fft Cycles:10 Average:84.30 Median:74.00 stddev:24.48 (33.1%) stddev-sans-first:25.68 12:39:16 INFO - PROCESS | 2009 | Values: 74.0 74.0 75.0 122.0 69.0 74.0 83.0 83.0 134.0 55.0 12:39:16 INFO - PROCESS | 2009 | 12:39:16 INFO - PROCESS | 2009 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:80.00 stddev:21.14 (26.4%) stddev-sans-first:22.39 12:39:16 INFO - PROCESS | 2009 | Values: 93.0 96.0 135.0 80.0 76.0 85.0 119.0 76.0 80.0 119.0 12:39:16 INFO - PROCESS | 2009 | 12:39:16 INFO - PROCESS | 2009 | [#5] imaging-gaussian-blur Cycles:10 Average:95.30 Median:88.00 stddev:17.94 (20.4%) stddev-sans-first:18.89 12:39:16 INFO - PROCESS | 2009 | Values: 89.0 88.0 88.0 88.0 89.0 78.0 133.0 124.0 90.0 86.0 12:39:16 INFO - PROCESS | 2009 | 12:39:16 INFO - PROCESS | 2009 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 12:39:16 INFO - PROCESS | 2009 | Values: 94.0 95.0 94.0 94.0 94.0 95.0 94.0 95.0 94.0 94.0 12:39:16 INFO - PROCESS | 2009 | 12:39:16 INFO - PROCESS | 2009 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.50 stddev:1.25 (1.5%) stddev-sans-first:1.09 12:39:16 INFO - PROCESS | 2009 | Values: 87.0 84.0 83.0 84.0 85.0 86.0 86.0 84.0 86.0 85.0 12:39:16 INFO - PROCESS | 2009 | 12:39:16 INFO - PROCESS | 2009 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.50 stddev:4.76 (8.3%) stddev-sans-first:5.04 12:39:16 INFO - PROCESS | 2009 | Values: 56.0 58.0 58.0 56.0 57.0 57.0 58.0 67.0 51.0 49.0 12:39:16 INFO - PROCESS | 2009 | 12:39:16 INFO - PROCESS | 2009 | [#9] json-stringify-tinderbox Cycles:10 Average:77.00 Median:71.50 stddev:14.26 (19.9%) stddev-sans-first:14.33 12:39:16 INFO - PROCESS | 2009 | Values: 64.0 69.0 62.0 74.0 82.0 101.0 98.0 87.0 66.0 67.0 12:39:16 INFO - PROCESS | 2009 | 12:39:16 INFO - PROCESS | 2009 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:79.00 stddev:1.77 (2.2%) stddev-sans-first:1.87 12:39:16 INFO - PROCESS | 2009 | Values: 79.0 80.0 78.0 79.0 79.0 79.0 78.0 78.0 79.0 84.0 12:39:16 INFO - PROCESS | 2009 | 12:39:16 INFO - PROCESS | 2009 | [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:119.50 stddev:4.24 (3.6%) stddev-sans-first:4.36 12:39:16 INFO - PROCESS | 2009 | Values: 116.0 118.0 121.0 125.0 120.0 112.0 117.0 119.0 126.0 116.0 12:39:16 INFO - PROCESS | 2009 | 12:39:16 INFO - PROCESS | 2009 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.00 Median:133.50 stddev:13.80 (10.3%) stddev-sans-first:14.62 12:39:16 INFO - PROCESS | 2009 | Values: 134.0 156.0 165.0 127.0 134.0 119.0 133.0 130.0 131.0 131.0 12:39:16 INFO - PROCESS | 2009 | 12:39:16 INFO - PROCESS | 2009 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 12:39:16 INFO - PROCESS | 2009 | Values: 65.0 67.0 66.0 65.0 65.0 65.0 65.0 65.0 65.0 64.0 12:39:16 INFO - PROCESS | 2009 | -------- Summary: end -------- 12:39:16 INFO - PROCESS | 2009 | 12:39:17 INFO - TEST-INFO | 2009: exit 0 12:39:17 INFO - TEST-OK | kraken | took 56528ms 12:39:17 INFO - SUITE-END | took 1170s 12:39:18 INFO - Completed test suite (00:19:31) 12:39:18 INFO - javascript benchmark 12:39:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3447.052060683312, 3512.2799826035666, 3513.7189024878, 3562.3943929531983, 3600.4419315006185, 5917.2307600012045, 5943.524518038563, 5962.850928726784, 5965.403459654032, 5975.37258587848, 5933.080372542263, 5982.521398288138, 5989.730462129204, 5992.250968628921, 5998.100284957259, 5180.896382072357, 5272.024675435047, 5284.339457567804, 5348.090824559834, 5396.541293990015, 5297.761600727958, 5378.0857254266675, 5395.59533035022, 5416.187571864232, 5417.349918009844, 5394.0, 5416.8104116355935, 5422.40353561108, 5423.267858839065, 5436.809711660093, 5368.543673787733, 5384.623076384654, 5392.757325920343, 5399.19012148177, 5470.507654311092, 5149.30484384607, 5204.895902081975, 5321.281626980347, 5324.41431442541, 5340.065488539529, 5748.683822389767, 5758.769649214027, 5839.503642190419, 5849.385814489502, 5874.882502349972, 6183.96908015457, 6254.530910181755, 6263.874722505524, 6275.529335299871, 6277.403646653561, 5946.762129514815, 6199.907001394983, 6222.097795819581, 6284.717187726564, 6319.494440444753, 5993.700314984277, 6073.134009451069, 6085.695715214221, 6105.542084343692, 6125.601835880653, 6380.361963803675, 6390.5526613136635, 6394.104825324458, 6397.6801159941815, 6406.967965160145, 6174.598651087665, 6228.626282423069, 6266.248050234001, 6307.779227727007, 6312.936870631327, 6272.059191121277, 6274.811755647338, 6275.623462592259, 6295.401936815995, 6308.558400911984, 6210.844728881814, 6213.65824879627, 6242.15730876335, 6261.029540421242, 6265.122882796412, 6198.845028874224, 6267.4986001119805, 6282.748690052346, 6290.937090629127, 6313.684315784192, 4370.519242883281, 4942.308076869242, 4987.9525299687475, 5025.170846810309, 5035.9928014397265, 4332.436783218224, 4405.845795397146, 4447.043885564619, 4474.664400170001, 4511.05267893746, 5849.7952571660635, 5902.970485147547, 5916.467517923322, 5922.733476993546, 5931.911021334683, 6248.968755156286, 6268.655223962726, 6307.5584709070845, 6313.873722525524, 6318.62088274705, 5756.395578464285, 5847.386024467455, 5882.823515294548, 5984.940150598525, 5992.850178745479, 5513.58648101394, 5519.641223320552, 5520.558355331564, 5524.226608274845, 5528.917066244009, 6476.4495017924, 6504.1219435375615, 6522.641254731036, 6525.0, 6553.803385898431, 6173.876522469615, 6241.500679945684, 6267.467265282502, 6294.937050629435, 6317.842053948688, 6478.6436745977535, 6518.054882042172, 6522.15212022434, 6534.444572211415, 6537.378948999837, 6166.321704612399, 6289.213848268966, 6302.086197501245, 6304.0, 6315.05274208854, 6208.565400422108, 6289.96855015722, 6309.211348581427, 6313.1477250572425, 6316.715747791269, 6230.719617617127, 6269.968650156902, 6276.372362763687, 6281.59169653971, 6294.968525157345, 6095.1466794647895, 6118.010103775157, 6226.439620434183, 6249.031400132987, 6324.272708638566, 6089.604175728564, 6096.573239873166, 6112.503480924647, 6133.824358647991, 6196.1015652731, 6263.279722831932, 6280.403361680633, 6292.748290068346, 6295.087212354091, 6299.023651334051, 6128.264608247039, 6160.845978850564, 6161.106639537332, 6167.84580385476, 6168.321484636776], "unit": "score", "name": "dojo.html", "value": 5832.568778033306}, {"lowerIsBetter": false, "replicates": [477.5415601023018, 597.4772074434869, 599.9280086389637, 657.0932113683118, 675.0178490296619, 39717.0, 40386.19227615446, 40393.0, 40468.39297410541, 40503.59496405035, 43442.0, 44190.0, 44195.77902110493, 44215.55784442154, 44310.33534496977, 9679.370840895355, 9908.256880733974, 9910.653127140551, 9920.45437500937, 9940.850887236697, 8244.340452763765, 9832.557534910946, 9843.0, 9936.453495057769, 9956.850647240297, 8460.830783384328, 9996.550155243032, 9996.750081247954, 10009.749756256115, 10014.248931330143, 9901.752456188617, 9994.150497207746, 9997.250206234561, 9998.900010999869, 10000.749981250417, 9691.70924872248, 9812.65655702047, 9819.754506137333, 9826.606935722562, 9830.852537211947, 42192.78903605462, 42446.78776606128, 42470.57529424728, 42515.574844251474, 42536.57463425388, 3389.5254664347012, 3491.965080349215, 3524.9295014099575, 3525.294941011808, 3677.3196958562753, 29341.413171736447, 29379.853100734574, 29755.404891902042, 29806.85096574525, 29863.25341866449, 2346.2609278077352, 2664.5203863304596, 2798.748112669849, 2825.834781266646, 2921.357301393711, 518845.0, 522797.0, 523271.0, 523688.0, 523916.38041809545, 73554.2644573558, 74005.0, 74020.25979740241, 74184.88722669164, 74239.14402139881, 77758.83361749578, 78556.0, 78699.8195027075, 78728.0, 79773.60113199397, 18168.545786355182, 18195.27218911255, 18347.633047339245, 18390.816091839177, 18421.171047302905, 13870.167789932637, 13942.302884855919, 13990.440382384793, 13993.230372329619, 13996.16023038621, 19491.53813463996, 20457.07943142562, 20492.38522844317, 22141.335759927228, 22806.201782937518, 9462.952685236529, 9625.278104142217, 9653.46905920181, 9686.564104615309, 9693.369930954465, 1027.2655051638114, 1041.6979076067855, 1056.4717641179411, 1072.9409882456384, 1140.7205234717546, 23912.641310380357, 26785.866070669523, 30072.548911766342, 30624.69375306263, 30678.238958493843, 820.6102101501858, 1096.8245080787196, 1099.961501347449, 1221.4930803716536, 1227.128738595607, 14333.354999025069, 14676.926615367069, 15065.849341506664, 15120.39518419251, 15150.015249008778, 553907.0, 554557.0, 563263.0, 563484.0, 564603.0, 61537.69231153816, 62005.37994620086, 62060.68969655123, 62173.37826621766, 62198.378016219256, 1390.5828251524501, 1522.8324884262722, 1540.4300408848574, 1554.65020370418, 1563.4215340323926, 24168.51662966766, 29290.681919313254, 30285.394292114474, 30347.0, 31009.0, 48584.757076214395, 48746.75626621844, 49097.50902490929, 49118.508814911394, 49121.50878491169, 329271.0, 331712.0, 331727.34136330127, 422485.0, 490075.0, 44793.77603111963, 47124.52875471202, 47246.0, 47672.0, 47764.0, 47939.520604793506, 48168.75915620539, 49672.751636241584, 49987.75006124946, 50895.0, 39143.60856391399, 39883.2023359537, 41850.0, 42257.366139508544, 43270.48553300619, 36470.0, 37809.62190378061, 41664.95837604084, 41877.0, 41978.37032444455, 40979.795101024305, 41105.38341924814, 42609.786951066286, 42779.786101069294, 42939.570604293556, 35729.28541429105, 35832.0, 36643.45034824533, 36658.0, 36728.0, 26760.866195668896, 26943.326416839736, 27198.592021119304, 27223.319417014733, 27572.448551028465], "unit": "score", "name": "ext.html", "value": 21008.49399432992}, {"lowerIsBetter": false, "replicates": [378.3473508198358, 381.61647544218073, 381.9847206111756, 384.4694321835866, 386.1273521840639, 19960.900195499038, 20492.0, 21111.788882111174, 21390.465238369048, 21399.57200855984, 12058.879411205886, 12459.0, 12575.748485030294, 12580.433880475377, 12593.748125037493, 5061.544460998519, 5995.940040599582, 6172.629642221481, 6190.288116866551, 6190.3190649028575, 6102.827788989334, 6123.877522449548, 6145.846353841145, 6153.384661533855, 6178.62928224308, 5864.296284445851, 6043.395660433944, 6044.4257795509575, 6050.969745151268, 6051.969740151293, 5640.182173584848, 5998.190244317027, 6023.518118550505, 6025.758969641231, 6029.638221706711, 5164.2253661950635, 5295.364556253236, 5320.654157479751, 5322.0686379883755, 5336.626436149471, 13633.386497607631, 14038.85961140396, 14156.009079364449, 14341.713165736732, 14392.496262630862, 1988.5128143604766, 2193.0, 2196.626573482512, 2225.265662331427, 2292.060255295338, 7705.61471926407, 9803.0, 13525.526606568723, 14427.71144577113, 14959.925200374037, 1677.7986641603086, 1730.1176400036072, 1785.9017754023523, 1825.516238196879, 1847.2610955617727, 91238.0, 108935.99999999921, 109164.0, 111180.0, 112428.87571124265, 11975.101867359983, 11983.0, 12020.699482512833, 12028.45871935765, 12070.577529786415, 14491.78262326066, 14576.125432474086, 14582.41670333196, 14615.853841461661, 14618.85381146175, 9112.179903808688, 9157.908420915839, 9169.0, 9178.128077832594, 9269.536523173949, 9405.717828465156, 9411.200047995997, 9427.292953028551, 9500.47747373901, 9504.811898512686, 4618.468876079294, 4708.505606911225, 4712.151812673752, 4754.429468463806, 4771.5228477152, 1933.941981740522, 1939.6702560564738, 1945.114972687452, 1962.5093726568357, 1988.6917527783216, 410.2308172177168, 446.8168051099034, 462.06662541666316, 469.13678830951216, 896.6996056321206, 11834.704132396759, 11862.332199257577, 12030.518779248732, 12230.082743794252, 12360.567380141652, 462.79174371532946, 478.5214785214785, 485.02267930120837, 489.22702130633513, 499.47804544251346, 5100.872478188075, 6328.46208072319, 6331.715072821734, 6379.425851673372, 6446.033095035688, 573911.0, 573974.0, 634863.0, 673087.0, 708477.0, 98483.50758246164, 124873.0, 125934.0, 126204.36897815453, 130600.34699826631, 1037.123630532214, 1049.6903413493037, 1075.0593230922943, 1078.8435676826816, 1082.5182793656904, 17178.453939145536, 18560.535986600444, 18820.15309311057, 19388.515287117934, 19757.50606234798, 42921.283148673705, 47273.527264726916, 47307.763461182476, 49346.50653493419, 51014.48985510246, 55440.891182176936, 62966.685166575706, 66770.33229667836, 66929.33070669425, 67096.32259193559, 7998.800029999296, 8065.55639439813, 8141.877871831809, 8183.140770219279, 8354.248117669196, 12862.356882156042, 13050.934745326213, 13165.407556660164, 13397.0, 13556.864431355954, 8909.866352004854, 11778.234414763014, 11825.822612660644, 11973.042156627624, 12036.976856967256, 11508.079353651856, 11620.6513804586, 11671.708207294885, 11746.353950532803, 11840.585579504675, 6117.327094019565, 11918.0, 11948.880511194777, 12028.0, 12093.911547960726, 8068.193180681885, 8116.959415202886, 8312.584370781558, 8503.91496085056, 8518.23335899772, 8928.821423571622, 11450.427478626201, 11726.237794543327, 11885.702857428634, 12090.126030465291], "unit": "score", "name": "jquery.html", "value": 8762.91412951972}, {"lowerIsBetter": false, "replicates": [1508.358947447336, 1642.228152768199, 1671.2897018767026, 2017.243533674872, 2094.6439105352097, 8313.542755148464, 8922.643094276229, 9094.226990705782, 9101.408408453446, 9120.452772833627, 8792.736217913456, 9027.961784394796, 9053.864192037125, 9056.366054376196, 9074.637014519429, 2281.041962375798, 2502.06172685243, 2560.283120726195, 2575.896964121433, 2587.379029033028, 2605.3747100695887, 2616.9214923552227, 2617.450335429562, 2621.6067589861577, 2632.197179860142, 2503.1364179358184, 2567.704713957891, 2571.8842652080702, 2575.90984315549, 2576.4203054312816, 2427.4295540547955, 2448.069733501267, 2496.3883848457062, 2510.0085466240826, 2511.1085564624477, 2214.568159208955, 2538.352720056392, 2586.5602847515966, 2599.9480010399875, 2613.973860261392, 9297.4886381249, 9343.486108264044, 9414.95292523533, 9426.811463770686, 9434.433933963915, 5742.598018138732, 5829.125631155318, 5881.764729410818, 5894.675792831393, 5899.793507227269, 3700.2414505026404, 3781.243751249761, 3847.7306588538813, 3861.5559210690567, 3867.941980870289, 1080.168270431771, 1083.7615724540667, 1085.636311835536, 1109.8335249712527, 1136.0343707848344, 12732.363381830872, 12745.681357966032, 12752.617421477464, 12762.106652534327, 12772.744545109139, 5119.6416250862085, 5131.7690703918415, 5244.501772331622, 5247.317848679723, 5252.763625636855, 10762.515686794113, 10812.297200681931, 10824.72938176536, 10843.51204195813, 10849.349039057524, 5777.595568310262, 5827.368336865685, 5831.0, 5835.891180675658, 5840.386759390288, 4607.14767767964, 4776.355192049098, 5067.721275329818, 5111.463296353903, 5175.482451754794, 4147.937780933288, 4214.768187749642, 4234.745915245096, 4257.87226383209, 4266.701330906807, 1348.4673553946136, 1352.0805852020524, 1355.241065003601, 1364.7952807079018, 1367.924764137962, 1403.0389183409397, 1410.0341266232663, 1442.4302400551933, 1452.6658868460102, 1473.7789331600345, 8596.097409772008, 8757.956210219036, 8767.167119123673, 8778.166074222938, 8778.736637900873, 521.3691433365594, 528.5692160888864, 536.9946300537023, 537.8037016489031, 541.2098336428858, 6427.421532062137, 6435.03474478832, 6484.319146489645, 6497.870042599122, 6500.837479063061, 11025.0, 11370.658880233606, 11384.886151138548, 11401.714957126138, 11418.600348987911, 10577.31247468912, 10912.454377281105, 11093.445327733742, 11157.163212758913, 11230.438478076227, 8573.22840944318, 8610.96668399796, 8660.393772435995, 8722.476651400937, 8758.386912916161, 8446.324294056583, 8450.661973521237, 8489.193526614961, 8546.743597692079, 8577.785555361166, 9732.854007189757, 9770.218382529523, 9869.358491698016, 9909.207263418764, 10009.299349045497, 10157.9492102539, 10463.162946964378, 10512.0, 10602.628907988183, 10762.46187690628, 7162.749303774552, 7342.412606991321, 7650.846983060419, 7720.7683769487, 7996.600169991593, 8695.956520217358, 8758.91241087581, 8765.649374024968, 8769.166929141722, 8770.824583508422, 7604.12552556441, 7678.923210767821, 7754.844903102019, 7833.1383547808555, 7853.175416581176, 7561.130469996021, 7596.240375962359, 7615.6953721850505, 7732.961335193288, 7775.961120194363, 8055.718049868226, 8227.0, 8231.34149268069, 8241.629126689433, 8264.545450000067, 7241.167265764505, 7451.515651482637, 7463.2163622818825, 7472.813179670552, 7488.138864030489, 7500.549967001997, 7562.773116806505, 7583.469157158946, 7598.354139898171, 7610.809729756579], "unit": "score", "name": "mootools.html", "value": 5103.516401768884}, {"lowerIsBetter": false, "replicates": [332.8252667349641, 337.79056984669506, 340.8057407277851, 341.27308832187435, 347.92519608284215, 6617.371349721769, 6663.600183988958, 6677.799666010022, 6723.899141512875, 6834.248232694412, 5859.970700146504, 5930.258717660293, 6369.140166077578, 6691.3977742003335, 6702.530822842403, 4765.928511072337, 4809.615230781546, 4906.975465122669, 4927.507249275061, 5014.674046187004, 4888.951110488885, 4906.901861962759, 4916.901661966758, 4918.680285781431, 4919.877003074916, 4897.191963326047, 4917.385326834145, 4918.508149185089, 4919.942212424328, 4926.236433352836, 3988.960110398917, 4732.361131247289, 4806.966502202026, 4918.385201849769, 4931.80272789088, 4219.071804203101, 4231.132617813341, 4232.809523571446, 4244.554321796198, 4257.97871010646, 6322.936770632281, 6404.263509696398, 6408.0, 6447.0, 6453.354664533556, 5930.495907847838, 5947.5539334550085, 5948.13752005961, 5950.7917222896995, 5951.137085122633, 6802.557833740791, 7151.74968876092, 7152.213256541776, 7155.3560179583565, 7166.3908567771805, 4642.396488456479, 4667.813287468497, 4693.507181745902, 4702.623790096784, 4709.034647897173, 6565.967170164118, 7115.786526404217, 7447.0, 7531.849363012764, 7538.698452061911, 3877.2245550889934, 3924.274009308287, 4707.152712511781, 4716.410448693913, 4731.810727570859, 4793.32893394925, 4808.158572249842, 4810.6632535722165, 4812.663113582015, 4832.081904438145, 4678.578927896506, 5756.02147634903, 5774.105013722879, 5786.623869448473, 5793.015187418149, 6842.384185423336, 7116.71533138679, 7121.0, 7151.53515021522, 7165.104361954755, 1641.9014859108493, 1676.639522502668, 1678.0602862397097, 1678.991605041967, 1679.1772031704377, 1019.90820826126, 1065.1265961911313, 1068.7167900506372, 1073.1897417449775, 1101.2071308657753, 6586.176727909012, 6596.010598410181, 6651.600903945682, 6665.966670166618, 6704.7988560343265, 7372.447066469929, 7373.446991475661, 7384.1877393486675, 7407.2222416646555, 7423.294786995227, 5456.972715136479, 6633.336666333425, 6635.402813746786, 6636.838553253161, 6639.0, 3859.8070096495626, 3906.374980003186, 3907.785071821077, 3911.471951286597, 3918.9216215676097, 7461.962690186514, 7720.922790772132, 7722.42081843864, 7731.7680469586, 7741.148473667892, 7647.847043059108, 7707.807304817312, 7729.652165652559, 7736.7292144774665, 7737.0715514138665, 7811.140774514799, 7827.25641064098, 7840.215978402114, 7843.803904902423, 7852.960735196288, 7085.383098647702, 7443.4789564729945, 7450.478466507292, 7451.40388768908, 7482.139553951365, 7291.08861392326, 7316.561006339423, 7321.487495875238, 7332.486725929347, 7349.0, 7735.419843511647, 7748.34139098183, 7758.456908016385, 7762.184970578008, 7778.883316750366, 4687.624990000723, 4727.267273572465, 4736.313234581035, 4744.4543877454535, 4745.738984355894, 7116.750913717995, 7407.333339999211, 7423.777286681408, 7424.480286379901, 7447.329740323397, 5160.741962901765, 7133.714651413885, 7175.8564828704175, 7175.8564828704175, 7178.28217178278, 5930.673812940329, 7087.610181439864, 7145.46409019336, 7154.35610795031, 7171.139463264233, 5770.451807078321, 6984.930150698428, 7012.298770122947, 7019.2629773873, 7029.5430796998035, 6665.0, 6870.7595234166565, 7155.356017958408, 7166.355028047501, 7183.568985860865, 6734.326567343226, 6934.549254298455, 6936.237013928363, 6944.201416836926, 7008.789736307919], "unit": "score", "name": "prototype.html", "value": 5195.625889188713}, {"lowerIsBetter": false, "replicates": [638.7958697854543, 712.9857402851942, 724.7825652304307, 742.918278989311, 780.274344859281, 14369.35337909794, 15399.692006159885, 15401.845981540182, 15406.92151549392, 15462.458813941486, 13212.933935330333, 14353.28233588319, 14427.0, 14435.566932992, 14449.711005779878, 794.940379471539, 992.5831150916596, 1014.8376259798433, 1015.8273093574073, 1017.8015287019034, 991.0535438656102, 999.3454287441701, 1007.6271779441616, 1010.7372083258332, 1011.1051719228499, 839.5424493650944, 855.1277696749312, 1064.5369264369986, 1069.1660504806264, 1074.0548317480645, 1042.7236782252671, 1066.9413182274973, 1070.411273799415, 1071.314358810362, 1073.50618715391, 789.5381201996839, 789.9921000789976, 791.0349373763999, 795.2167115391335, 799.0571126071234, 14939.775903361458, 14995.400183992628, 15002.849971500364, 15018.399264029425, 15042.247887605576, 11794.882051179464, 12963.870361296455, 12993.805092923614, 13217.273049982246, 13372.933135334359, 10169.59321627134, 10480.266381353309, 11159.609413670563, 11193.44032798365, 11761.705957351049, 3456.2914602506676, 3528.311979164064, 3566.35805555, 3607.3687104756564, 3648.543932008499, 90982.0, 92997.0, 93039.0, 93202.5339873303, 93292.53353733255, 9334.71995840126, 9719.271054670928, 9770.92519822819, 9929.851052234222, 10206.23453240995, 21950.231741889278, 22003.009864556134, 22072.668909966364, 22079.33761987143, 22275.77724222737, 7513.32380085784, 7630.38956883448, 7787.922120778833, 7800.45396822217, 7866.685332586747, 3815.0, 3989.7207195496035, 4020.3567429211184, 4041.8787436376956, 4078.1232035112594, 3589.9820500897326, 3619.49327094207, 3623.474596183539, 3623.8550457981387, 3630.074331045619, 610.2341561340489, 623.9500839932795, 657.3656421553128, 706.2231545300128, 731.377692980359, 567.5743192605546, 570.37543889441, 598.3149294058279, 624.7875722254364, 632.5635311634957, 8174.877376839352, 8589.871151932726, 8590.828183436297, 8594.35542334315, 8613.913860861312, 541.7318427378473, 582.4263100845664, 597.4324391827694, 604.3684349854412, 634.8984162533973, 3968.0675041365257, 4035.2534781065597, 4138.544760076389, 4253.723507971972, 4289.142171565637, 86906.56546717226, 89159.55420222858, 92100.0, 92958.0, 93880.0611993885, 41700.582994170276, 49928.0, 65125.04624861262, 74575.0, 77206.0, 68695.0, 69021.999999999, 69025.65487172632, 69392.0, 69482.30517694859, 8600.13998600135, 8645.913540864762, 8646.481211127353, 8804.471731695863, 8822.95588522079, 45620.315695265264, 46153.30770038385, 46848.765756171, 46974.82562935817, 47032.0, 45752.771236143606, 52832.73583632057, 55077.72461137669, 61863.6906815463, 61934.690326549884, 11113.277636953571, 11226.494807733508, 11307.265027773497, 11624.709382265512, 11845.644630661094, 11920.688007644363, 12091.029252330378, 12122.636320910387, 12220.877791221974, 12367.319797411228, 11197.888021119685, 11553.24903881245, 11597.420128993348, 11806.232594881305, 12009.699757506132, 12066.698332541757, 12106.334151621746, 12120.878791211975, 12214.694632634255, 12217.572384966483, 11792.646220613395, 11816.645500634995, 11894.0, 11948.462319195483, 12104.75790484203, 9768.560414781494, 9871.160951319218, 9890.752731181778, 9993.350432221881, 10152.03555662211, 9595.22633498468, 9640.897409182391, 9713.36863103896, 9752.707418777449, 9995.400275983464], "unit": "score", "name": "yui.html", "value": 7052.352300975281}], "name": "dromaeo_css", "value": 7652.379996673676}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 111.0, 110.0, 112.0, 110.0, 117.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [153.0, 120.0, 154.0, 146.0, 116.0, 139.0, 116.0, 149.0, 146.0, 115.0], "unit": "score", "name": "audio-beat-detection", "value": 135.4}, {"lowerIsBetter": true, "replicates": [183.0, 186.0, 185.0, 188.0, 184.0, 187.0, 185.0, 186.0, 188.0, 260.0], "unit": "score", "name": "audio-dft", "value": 193.2}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 75.0, 122.0, 69.0, 74.0, 83.0, 83.0, 134.0, 55.0], "unit": "score", "name": "audio-fft", "value": 84.3}, {"lowerIsBetter": true, "replicates": [93.0, 96.0, 135.0, 80.0, 76.0, 85.0, 119.0, 76.0, 80.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 95.9}, {"lowerIsBetter": true, "replicates": [89.0, 88.0, 88.0, 88.0, 89.0, 78.0, 133.0, 124.0, 90.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 95.3}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 94.3}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 83.0, 84.0, 85.0, 86.0, 86.0, 84.0, 86.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.0}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 58.0, 56.0, 57.0, 57.0, 58.0, 67.0, 51.0, 49.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [64.0, 69.0, 62.0, 74.0, 82.0, 101.0, 98.0, 87.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 77.0}, {"lowerIsBetter": true, "replicates": [79.0, 80.0, 78.0, 79.0, 79.0, 79.0, 78.0, 78.0, 79.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.3}, {"lowerIsBetter": true, "replicates": [116.0, 118.0, 121.0, 125.0, 120.0, 112.0, 117.0, 119.0, 126.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.0}, {"lowerIsBetter": true, "replicates": [134.0, 156.0, 165.0, 127.0, 134.0, 119.0, 133.0, 130.0, 131.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.0}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.2}], "name": "kraken", "value": 1427.8}]} 12:39:18 INFO - Return code: 0 12:39:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:39:18 INFO - # TBPL SUCCESS # 12:39:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:39:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:39:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:39:18 INFO - 2016-03-15 12:39:18.224 screenresolution[2013:12495] starting screenresolution argv=screenresolution get 12:39:18 INFO - 2016-03-15 12:39:18.227 screenresolution[2013:12495] Display 0: 1600x1200x32@60 12:39:18 INFO - 2016-03-15 12:39:18.233 screenresolution[2014:12498] starting screenresolution argv=screenresolution list 12:39:18 INFO - Available Modes on Display 0 12:39:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:39:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:39:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:39:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:39:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:39:18 INFO - Intel Iris: 12:39:18 INFO - Chipset Model: Intel Iris 12:39:18 INFO - Type: GPU 12:39:18 INFO - Bus: Built-In 12:39:18 INFO - VRAM (Dynamic, Max): 1536 MB 12:39:18 INFO - Vendor: Intel (0x8086) 12:39:18 INFO - Device ID: 0x0a2e 12:39:18 INFO - Revision ID: 0x0009 12:39:18 INFO - Displays: 12:39:18 INFO - Display: 12:39:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:39:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:39:18 INFO - Display Serial Number: 1600x1200 60 12:39:18 INFO - Main Display: Yes 12:39:18 INFO - Mirror: Off 12:39:18 INFO - Online: Yes 12:39:18 INFO - Rotation: Supported 12:39:18 INFO - Return code: 0 12:39:18 INFO - Running post-action listener: _resource_record_post_action 12:39:18 INFO - Running post-run listener: _resource_record_post_run 12:39:19 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 491520; Write bytes: 662231552; Read time: 11; Write time: 2361 12:39:19 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 351867392; Write bytes: 353699840; Read time: 27999; Write time: 861 12:39:19 INFO - run-tests - Wall time: 1173s; CPU: 52.0%; Read bytes: 491520; Write bytes: 298193408; Read time: 11; Write time: 1466 12:39:19 INFO - Running post-run listener: _upload_blobber_files 12:39:19 INFO - Blob upload gear active. 12:39:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:39:19 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 12:39:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:39:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:39:19 INFO - (blobuploader) - INFO - Open directory for files ... 12:39:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:39:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:39:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:20 INFO - (blobuploader) - INFO - Done attempting. 12:39:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:39:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:39:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:21 INFO - (blobuploader) - INFO - Done attempting. 12:39:21 INFO - (blobuploader) - INFO - Iteration through files over. 12:39:21 INFO - Return code: 0 12:39:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:39:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:39:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b261b268dd5addd9a4953751b5c61b1e08b49cf36d5f6219f02485f52b0cc950266c8feb340dba54da143803f943e33a844081b070594a5a0122bc1c565716e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/039cd1419f3a1e45cf30f18a820353cb3eff5dcee68e9ec8ac18adb5c1ffdacf3044d0ec29c1940e0853f3dd8b57ab864024037fa0d676893af909942e468f61"} 12:39:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:39:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:39:21 INFO - Contents: 12:39:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b261b268dd5addd9a4953751b5c61b1e08b49cf36d5f6219f02485f52b0cc950266c8feb340dba54da143803f943e33a844081b070594a5a0122bc1c565716e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/039cd1419f3a1e45cf30f18a820353cb3eff5dcee68e9ec8ac18adb5c1ffdacf3044d0ec29c1940e0853f3dd8b57ab864024037fa0d676893af909942e468f61"} 12:39:21 INFO - Running post-run listener: copy_logs_to_upload_dir 12:39:21 INFO - Copying logs to upload dir... 12:39:21 INFO - mkdir: /builds/slave/test/build/upload/logs 12:39:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.338154 ========= master_lag: 0.44 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-03-15 12:39:22.274959) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 12:39:22.278268) ========= 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.qpfWFxxHr8/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.zlVGQMKFPT/Listeners TMPDIR=/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b261b268dd5addd9a4953751b5c61b1e08b49cf36d5f6219f02485f52b0cc950266c8feb340dba54da143803f943e33a844081b070594a5a0122bc1c565716e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/039cd1419f3a1e45cf30f18a820353cb3eff5dcee68e9ec8ac18adb5c1ffdacf3044d0ec29c1940e0853f3dd8b57ab864024037fa0d676893af909942e468f61"} build_url:https://queue.taskcluster.net/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011155 build_url: 'https://queue.taskcluster.net/v1/task/aGkQSh-SSw-rn2_vDd8c2w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b261b268dd5addd9a4953751b5c61b1e08b49cf36d5f6219f02485f52b0cc950266c8feb340dba54da143803f943e33a844081b070594a5a0122bc1c565716e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/039cd1419f3a1e45cf30f18a820353cb3eff5dcee68e9ec8ac18adb5c1ffdacf3044d0ec29c1940e0853f3dd8b57ab864024037fa0d676893af909942e468f61"}' ========= master_lag: 0.98 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 12:39:23.268776) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 12:39:23.269110) ========= 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.qpfWFxxHr8/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.zlVGQMKFPT/Listeners TMPDIR=/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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.005168 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 12:39:23.327262) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 12:39:23.327532) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 12:39:23.328040) ========= ========= Total master_lag: 1.64 =========