builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0170 starttime: 1457997390.52 results: success (0) buildid: 20160314142340 builduid: 64dcc628ba064760b064f048b2642cf1 revision: 5e9097f4bf87974241e6c1673c4a5633d888f9ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 16:16:30.515927) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 16:16:30.516338) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 16:16:30.516624) ========= 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.kEYhwVLtHj/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.eeA7HXZwUs/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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.005762 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 16:16:30.543559) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 16:16:30.546869) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 16:16:30.563997) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:16:30.564288) ========= 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.kEYhwVLtHj/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.eeA7HXZwUs/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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.005648 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:16:30.612433) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 16:16:30.612725) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 16:16:30.616097) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:16:30.616386) ========= 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.kEYhwVLtHj/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.eeA7HXZwUs/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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-14 16:16:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.0M=0.001s 2016-03-14 16:16:30 (14.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164329 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:16:30.796679) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:16:30.797004) ========= 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.kEYhwVLtHj/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.eeA7HXZwUs/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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.030071 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:16:30.848061) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-14 16:16:30.848402) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5e9097f4bf87974241e6c1673c4a5633d888f9ad --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 5e9097f4bf87974241e6c1673c4a5633d888f9ad --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kEYhwVLtHj/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.eeA7HXZwUs/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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-14 16:16:30,928 truncating revision to first 12 chars 2016-03-14 16:16:30,928 Setting DEBUG logging. 2016-03-14 16:16:30,928 attempt 1/10 2016-03-14 16:16:30,929 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5e9097f4bf87?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-14 16:16:31,789 unpacking tar archive at: mozilla-aurora-5e9097f4bf87/testing/mozharness/ program finished with exit code 0 elapsedTime=1.109702 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-14 16:16:31.979690) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 16:16:31.983246) ========= echo 5e9097f4bf87974241e6c1673c4a5633d888f9ad in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5e9097f4bf87974241e6c1673c4a5633d888f9ad'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kEYhwVLtHj/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.eeA7HXZwUs/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 5e9097f4bf87974241e6c1673c4a5633d888f9ad program finished with exit code 0 elapsedTime=0.005326 script_repo_revision: '5e9097f4bf87974241e6c1673c4a5633d888f9ad' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 16:16:32.036362) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 16:16:32.036678) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 16:16:32.050575) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-03-14 16:16:32.050879) ========= /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.kEYhwVLtHj/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.eeA7HXZwUs/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 16:16:32 INFO - MultiFileLogger online at 20160314 16:16:32 in /builds/slave/test 16:16:32 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 16:16:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:16:32 INFO - {'append_to_log': False, 16:16:32 INFO - 'base_work_dir': '/builds/slave/test', 16:16:32 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:16:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:16:32 INFO - 'branch': 'Mozilla-Aurora', 16:16:32 INFO - 'buildbot_json_path': 'buildprops.json', 16:16:32 INFO - 'config_files': ('talos/mac_config.py',), 16:16:32 INFO - 'default_actions': ('clobber', 16:16:32 INFO - 'read-buildbot-config', 16:16:32 INFO - 'download-and-extract', 16:16:32 INFO - 'populate-webroot', 16:16:32 INFO - 'create-virtualenv', 16:16:32 INFO - 'install', 16:16:32 INFO - 'run-tests'), 16:16:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:16:32 INFO - 'download_minidump_stackwalk': True, 16:16:32 INFO - 'download_symbols': 'ondemand', 16:16:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:16:32 INFO - 'tooltool.py': '/tools/tooltool.py', 16:16:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:16:32 INFO - '/tools/misc-python/virtualenv.py')}, 16:16:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:16:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:16:32 INFO - 'installer_path': 'installer.exe', 16:16:32 INFO - 'log_level': 'info', 16:16:32 INFO - 'log_name': 'talos', 16:16:32 INFO - 'log_to_console': True, 16:16:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:16:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:16:32 INFO - 'opt_config_files': (), 16:16:32 INFO - 'pip_index': False, 16:16:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:16:32 INFO - 'cmd': ('bash', 16:16:32 INFO - '-c', 16:16:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:16:32 INFO - 'enabled': True, 16:16:32 INFO - 'halt_on_failure': False, 16:16:32 INFO - 'name': 'check_screen_resolution'},), 16:16:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:16:32 INFO - 'cmd': ('bash', 16:16:32 INFO - '-c', 16:16:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:16:32 INFO - 'enabled': True, 16:16:32 INFO - 'halt_on_failure': False, 16:16:32 INFO - 'name': 'check_screen_resolution'},), 16:16:32 INFO - 'run_cmd_checks_enabled': True, 16:16:32 INFO - 'sps_profile': False, 16:16:32 INFO - 'sps_profile_interval': 0, 16:16:32 INFO - 'suite': 'dromaeojs', 16:16:32 INFO - 'system_bits': '32', 16:16:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:16:32 INFO - 'title': 't-yosemite-r7-0170', 16:16:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:16:32 INFO - 'use_talos_json': True, 16:16:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:16:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:16:32 INFO - 'work_dir': 'build'} 16:16:32 INFO - ##### 16:16:32 INFO - ##### Running clobber step. 16:16:32 INFO - ##### 16:16:32 INFO - Running pre-action listener: _resource_record_pre_action 16:16:32 INFO - Running main action method: clobber 16:16:32 INFO - rmtree: /builds/slave/test/build 16:16:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:16:33 INFO - Running post-action listener: _resource_record_post_action 16:16:33 INFO - ##### 16:16:33 INFO - ##### Running read-buildbot-config step. 16:16:33 INFO - ##### 16:16:33 INFO - Running pre-action listener: _resource_record_pre_action 16:16:33 INFO - Running main action method: read_buildbot_config 16:16:33 INFO - Using buildbot properties: 16:16:33 INFO - { 16:16:33 INFO - "project": "", 16:16:33 INFO - "product": "firefox", 16:16:33 INFO - "script_repo_revision": "production", 16:16:33 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 16:16:33 INFO - "repository": "", 16:16:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 16:16:33 INFO - "buildid": "20160314142340", 16:16:33 INFO - "pgo_build": "False", 16:16:33 INFO - "basedir": "/builds/slave/test", 16:16:33 INFO - "buildnumber": 215, 16:16:33 INFO - "slavename": "t-yosemite-r7-0170", 16:16:33 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:16:33 INFO - "platform": "yosemite_r7", 16:16:33 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:16:33 INFO - "branch": "mozilla-aurora", 16:16:33 INFO - "repo_path": "releases/mozilla-aurora", 16:16:33 INFO - "revision": "5e9097f4bf87974241e6c1673c4a5633d888f9ad", 16:16:33 INFO - "stage_platform": "macosx64", 16:16:33 INFO - "builduid": "64dcc628ba064760b064f048b2642cf1", 16:16:33 INFO - "slavebuilddir": "test" 16:16:33 INFO - } 16:16:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/OfOviVFKQx6bobI5FpZ6zQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 16:16:33 INFO - Running post-action listener: _resource_record_post_action 16:16:33 INFO - ##### 16:16:33 INFO - ##### Running download-and-extract step. 16:16:33 INFO - ##### 16:16:33 INFO - Running pre-action listener: _resource_record_pre_action 16:16:33 INFO - Running main action method: download_and_extract 16:16:33 INFO - mkdir: /builds/slave/test/build/tests 16:16: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')]} 16:16:33 INFO - https://queue.taskcluster.net/v1/task/OfOviVFKQx6bobI5FpZ6zQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:16:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfOviVFKQx6bobI5FpZ6zQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 16:16:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfOviVFKQx6bobI5FpZ6zQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 16:16:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfOviVFKQx6bobI5FpZ6zQ/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 16:16:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfOviVFKQx6bobI5FpZ6zQ/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 16:16:34 INFO - Downloaded 1277 bytes. 16:16:34 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 16:16:34 INFO - Using the following test package requirements: 16:16:34 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 16:16:34 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:16:34 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 16:16:34 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:16:34 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 16:16:34 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:16:34 INFO - u'jsshell-mac.zip'], 16:16:34 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:16:34 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 16:16:34 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 16:16:34 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:16:34 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 16:16:34 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:16:34 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 16:16:34 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:16:34 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 16:16:34 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 16:16:34 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:16:34 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 16:16:34 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:16: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')]} 16:16:34 INFO - https://queue.taskcluster.net/v1/task/OfOviVFKQx6bobI5FpZ6zQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:16:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfOviVFKQx6bobI5FpZ6zQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:16:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfOviVFKQx6bobI5FpZ6zQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:16:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfOviVFKQx6bobI5FpZ6zQ/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 16:16:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfOviVFKQx6bobI5FpZ6zQ/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 16:16:36 INFO - Downloaded 17865027 bytes. 16:16:36 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'] 16:16:36 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 16:16:39 INFO - Return code: 0 16:16:39 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 16:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:39 INFO - https://queue.taskcluster.net/v1/task/OfOviVFKQx6bobI5FpZ6zQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:16:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfOviVFKQx6bobI5FpZ6zQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:16:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfOviVFKQx6bobI5FpZ6zQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:16:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfOviVFKQx6bobI5FpZ6zQ/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 16:16:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfOviVFKQx6bobI5FpZ6zQ/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 16:16:40 INFO - Downloaded 17865027 bytes. 16:16:40 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'] 16:16:40 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 16:16:44 INFO - Return code: 0 16:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:44 INFO - https://queue.taskcluster.net/v1/task/OfOviVFKQx6bobI5FpZ6zQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:16:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfOviVFKQx6bobI5FpZ6zQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 16:16:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfOviVFKQx6bobI5FpZ6zQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 16:16:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfOviVFKQx6bobI5FpZ6zQ/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 16:16:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfOviVFKQx6bobI5FpZ6zQ/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 16:16:44 INFO - Downloaded 10845161 bytes. 16:16:44 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'] 16:16:44 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 16:16:45 INFO - Return code: 0 16:16: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')]} 16:16:45 INFO - https://queue.taskcluster.net/v1/task/OfOviVFKQx6bobI5FpZ6zQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 16:16:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfOviVFKQx6bobI5FpZ6zQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 16:16:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfOviVFKQx6bobI5FpZ6zQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 16:16:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfOviVFKQx6bobI5FpZ6zQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 16:16:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfOviVFKQx6bobI5FpZ6zQ/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 16:16:49 INFO - Downloaded 115015117 bytes. 16:16:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OfOviVFKQx6bobI5FpZ6zQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 16:16:49 INFO - mkdir: /builds/slave/test/properties 16:16:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:16:49 INFO - Writing to file /builds/slave/test/properties/build_url 16:16:49 INFO - Contents: 16:16:49 INFO - build_url:https://queue.taskcluster.net/v1/task/OfOviVFKQx6bobI5FpZ6zQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 16:16:50 INFO - Running post-action listener: _resource_record_post_action 16:16:50 INFO - Running post-action listener: set_extra_try_arguments 16:16:50 INFO - ##### 16:16:50 INFO - ##### Running populate-webroot step. 16:16:50 INFO - ##### 16:16:50 INFO - Running pre-action listener: _resource_record_pre_action 16:16:50 INFO - Running main action method: populate_webroot 16:16:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:16:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:16:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:16:50 INFO - '--tppagecycles', 16:16:50 INFO - '7'], 16:16:50 INFO - 'tests': ['tsvgm']}}, 16:16:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:16:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:16:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:16:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:16:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:16:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:16:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:16:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:50 INFO - 'talos_options': ['--e10s'], 16:16:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:16:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:50 INFO - 'tests': ['damp', 'tps']}, 16:16:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:50 INFO - 'talos_options': ['--e10s'], 16:16:50 INFO - 'tests': ['damp', 'tps']}, 16:16:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:16:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:16:50 INFO - 'other': {'tests': ['a11yr', 16:16:50 INFO - 'ts_paint', 16:16:50 INFO - 'tpaint', 16:16:50 INFO - 'sessionrestore', 16:16:50 INFO - 'sessionrestore_no_auto_restore', 16:16:50 INFO - 'tabpaint']}, 16:16:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:16:50 INFO - 'tests': ['a11yr', 16:16:50 INFO - 'ts_paint', 16:16:50 INFO - 'tpaint', 16:16:50 INFO - 'sessionrestore', 16:16:50 INFO - 'sessionrestore_no_auto_restore', 16:16:50 INFO - 'tabpaint']}, 16:16:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:16:50 INFO - 'tests': ['a11yr', 16:16:50 INFO - 'ts_paint', 16:16:50 INFO - 'tpaint', 16:16:50 INFO - 'sessionrestore', 16:16:50 INFO - 'sessionrestore_no_auto_restore', 16:16:50 INFO - 'tabpaint']}, 16:16:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:16:50 INFO - 'tests': ['a11yr', 16:16:50 INFO - 'ts_paint', 16:16:50 INFO - 'tpaint', 16:16:50 INFO - 'sessionrestore', 16:16:50 INFO - 'sessionrestore_no_auto_restore', 16:16:50 INFO - 'tabpaint']}, 16:16:50 INFO - 'other_l64': {'tests': ['a11yr', 16:16:50 INFO - 'ts_paint', 16:16:50 INFO - 'tpaint', 16:16:50 INFO - 'sessionrestore', 16:16:50 INFO - 'sessionrestore_no_auto_restore', 16:16:50 INFO - 'tabpaint']}, 16:16:50 INFO - 'other_nol64': {'tests': ['a11yr', 16:16:50 INFO - 'ts_paint', 16:16:50 INFO - 'tpaint', 16:16:50 INFO - 'sessionrestore', 16:16:50 INFO - 'sessionrestore_no_auto_restore', 16:16:50 INFO - 'tabpaint']}, 16:16:50 INFO - 'svgr': {'tests': ['tsvgx', 16:16:50 INFO - 'tsvgr_opacity', 16:16:50 INFO - 'tart', 16:16:50 INFO - 'tscrollx', 16:16:50 INFO - 'cart']}, 16:16:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:16:50 INFO - 'tests': ['tsvgx', 16:16:50 INFO - 'tsvgr_opacity', 16:16:50 INFO - 'tart', 16:16:50 INFO - 'tscrollx', 16:16:50 INFO - 'cart']}, 16:16:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:50 INFO - 'tests': ['tp5o']}, 16:16:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:50 INFO - 'talos_options': ['--e10s'], 16:16:50 INFO - 'tests': ['tp5o']}, 16:16:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:50 INFO - 'talos_options': ['--xperf_path', 16:16:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:16:50 INFO - 'tests': ['tp5n']}, 16:16:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:50 INFO - 'talos_options': ['--e10s', 16:16:50 INFO - '--xperf_path', 16:16:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:16:50 INFO - 'tests': ['tp5n']}}, 16:16:50 INFO - 'talos.zip': {'path': '', 16:16:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:16:50 INFO - Running post-action listener: _resource_record_post_action 16:16:50 INFO - ##### 16:16:50 INFO - ##### Running create-virtualenv step. 16:16:50 INFO - ##### 16:16:50 INFO - Running pre-action listener: _resource_record_pre_action 16:16:50 INFO - Running main action method: create_virtualenv 16:16:50 INFO - Creating virtualenv /builds/slave/test/build/venv 16:16:50 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 16:16:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:16:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:16:50 INFO - Using real prefix '/tools/python27' 16:16:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:16:51 INFO - Installing distribute.............................................................................................................................................................................................done. 16:16:54 INFO - Installing pip.................done. 16:16:54 INFO - Return code: 0 16:16:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:16: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')]} 16:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16: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')]} 16:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:54 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 0x101ff3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ffa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f975aeb6dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e97d30>, '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 0x101cfbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e8eb20>, '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.kEYhwVLtHj/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.eeA7HXZwUs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 16:16:54 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 16:16:54 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 16:16:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kEYhwVLtHj/Render', 16:16:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:54 INFO - 'HOME': '/Users/cltbld', 16:16:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:54 INFO - 'LOGNAME': 'cltbld', 16:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:54 INFO - 'MOZ_NO_REMOTE': '1', 16:16:54 INFO - 'NO_EM_RESTART': '1', 16:16:54 INFO - 'PAGER': '/bin/cat', 16:16:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:54 INFO - 'PWD': '/builds/slave/test', 16:16:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:54 INFO - 'SHELL': '/bin/bash', 16:16:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eeA7HXZwUs/Listeners', 16:16:54 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 16:16:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:54 INFO - 'USER': 'cltbld', 16:16:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:54 INFO - 'XPC_FLAGS': '0x0', 16:16:54 INFO - 'XPC_SERVICE_NAME': '0', 16:16:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:54 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 16:16:54 INFO - Cleaning up... 16:16:54 INFO - Return code: 0 16:16:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:16: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')]} 16:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16: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')]} 16:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:54 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 0x101ff3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ffa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f975aeb6dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e97d30>, '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 0x101cfbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e8eb20>, '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.kEYhwVLtHj/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.eeA7HXZwUs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 16:16:54 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 16:16:54 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 16:16:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kEYhwVLtHj/Render', 16:16:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:54 INFO - 'HOME': '/Users/cltbld', 16:16:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:54 INFO - 'LOGNAME': 'cltbld', 16:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:54 INFO - 'MOZ_NO_REMOTE': '1', 16:16:54 INFO - 'NO_EM_RESTART': '1', 16:16:54 INFO - 'PAGER': '/bin/cat', 16:16:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:54 INFO - 'PWD': '/builds/slave/test', 16:16:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:54 INFO - 'SHELL': '/bin/bash', 16:16:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eeA7HXZwUs/Listeners', 16:16:54 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 16:16:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:54 INFO - 'USER': 'cltbld', 16:16:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:54 INFO - 'XPC_FLAGS': '0x0', 16:16:54 INFO - 'XPC_SERVICE_NAME': '0', 16:16:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:54 INFO - Downloading/unpacking psutil>=0.7.1 16:16:54 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 16:16:54 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 16:16:54 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 16:16:54 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 16:16:54 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 16:16:54 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 16:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:16:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:16:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:16:57 INFO - Installing collected packages: psutil 16:16:57 INFO - Running setup.py install for psutil 16:16:57 INFO - building 'psutil._psutil_osx' extension 16:16:57 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 16:16:58 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 16:16:58 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 16:16:58 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 16:16:58 INFO - building 'psutil._psutil_posix' extension 16:16:58 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 16:16:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:16:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:16:58 INFO - ^ 16:16:58 INFO - 1 warning generated. 16:16:58 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 16:16:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:16:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:16:58 INFO - Successfully installed psutil 16:16:58 INFO - Cleaning up... 16:16:58 INFO - Return code: 0 16:16:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:16:58 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')]} 16:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:58 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')]} 16:16:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:58 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 0x101ff3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ffa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f975aeb6dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e97d30>, '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 0x101cfbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e8eb20>, '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.kEYhwVLtHj/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.eeA7HXZwUs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 16:16:58 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 16:16:58 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 16:16:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kEYhwVLtHj/Render', 16:16:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:58 INFO - 'HOME': '/Users/cltbld', 16:16:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:58 INFO - 'LOGNAME': 'cltbld', 16:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:58 INFO - 'MOZ_NO_REMOTE': '1', 16:16:58 INFO - 'NO_EM_RESTART': '1', 16:16:58 INFO - 'PAGER': '/bin/cat', 16:16:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:58 INFO - 'PWD': '/builds/slave/test', 16:16:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:58 INFO - 'SHELL': '/bin/bash', 16:16:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eeA7HXZwUs/Listeners', 16:16:58 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 16:16:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:58 INFO - 'USER': 'cltbld', 16:16:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:58 INFO - 'XPC_FLAGS': '0x0', 16:16:58 INFO - 'XPC_SERVICE_NAME': '0', 16:16:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:17:01 INFO - Installing collected packages: mozsystemmonitor 16:17:01 INFO - Running setup.py install for mozsystemmonitor 16:17:01 INFO - Successfully installed mozsystemmonitor 16:17:01 INFO - Cleaning up... 16:17:01 INFO - Return code: 0 16:17:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101ff3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ffa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f975aeb6dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e97d30>, '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 0x101cfbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e8eb20>, '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.kEYhwVLtHj/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.eeA7HXZwUs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 16:17:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:17:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kEYhwVLtHj/Render', 16:17:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:17:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:17:01 INFO - 'HOME': '/Users/cltbld', 16:17:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:17:01 INFO - 'LOGNAME': 'cltbld', 16:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:01 INFO - 'MOZ_NO_REMOTE': '1', 16:17:01 INFO - 'NO_EM_RESTART': '1', 16:17:01 INFO - 'PAGER': '/bin/cat', 16:17:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:01 INFO - 'PWD': '/builds/slave/test', 16:17:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:17:01 INFO - 'SHELL': '/bin/bash', 16:17:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eeA7HXZwUs/Listeners', 16:17:01 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 16:17:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:17:01 INFO - 'USER': 'cltbld', 16:17:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:17:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:01 INFO - 'XPC_FLAGS': '0x0', 16:17:01 INFO - 'XPC_SERVICE_NAME': '0', 16:17:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:01 INFO - Downloading/unpacking blobuploader==1.2.4 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17:04 INFO - Downloading blobuploader-1.2.4.tar.gz 16:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:17:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:17:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:17:05 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 16:17:05 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 16:17:05 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 16:17:05 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 16:17:05 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 16:17:05 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 16:17:05 INFO - Downloading docopt-0.6.1.tar.gz 16:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:17:05 INFO - Installing collected packages: blobuploader, requests, docopt 16:17:05 INFO - Running setup.py install for blobuploader 16:17:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:17:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:17:05 INFO - Running setup.py install for requests 16:17:06 INFO - Running setup.py install for docopt 16:17:06 INFO - Successfully installed blobuploader requests docopt 16:17:06 INFO - Cleaning up... 16:17:06 INFO - Return code: 0 16:17:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:17:06 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')]} 16:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:06 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')]} 16:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:06 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 0x101ff3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ffa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f975aeb6dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e97d30>, '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 0x101cfbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e8eb20>, '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.kEYhwVLtHj/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.eeA7HXZwUs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 16:17:06 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 16:17:06 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 16:17:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kEYhwVLtHj/Render', 16:17:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:17:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:17:06 INFO - 'HOME': '/Users/cltbld', 16:17:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:17:06 INFO - 'LOGNAME': 'cltbld', 16:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:06 INFO - 'MOZ_NO_REMOTE': '1', 16:17:06 INFO - 'NO_EM_RESTART': '1', 16:17:06 INFO - 'PAGER': '/bin/cat', 16:17:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:06 INFO - 'PWD': '/builds/slave/test', 16:17:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:17:06 INFO - 'SHELL': '/bin/bash', 16:17:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eeA7HXZwUs/Listeners', 16:17:06 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 16:17:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:17:06 INFO - 'USER': 'cltbld', 16:17:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:17:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:06 INFO - 'XPC_FLAGS': '0x0', 16:17:06 INFO - 'XPC_SERVICE_NAME': '0', 16:17:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:17:06 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-V3JAn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:17:06 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-IFYbSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:17:06 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-vKl_q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:17:07 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-TYmTw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:17:07 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-H2GBmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:17:07 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-WjZQFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:17:07 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-9EFb21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:17:07 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-cQZveC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:17:07 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-SKIJ6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:17:07 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-xDzp20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:17:07 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-Nx2S0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:17:07 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-Y_ZjDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:17:07 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-9jK8Wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:17:08 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-gMGwBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:17:08 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-ZvAFVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:17:08 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-_vZmcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:17:08 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-b8ZeY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:17:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:17:08 INFO - Running setup.py install for manifestparser 16:17:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:17:08 INFO - Running setup.py install for mozcrash 16:17:08 INFO - Running setup.py install for mozdebug 16:17:08 INFO - Running setup.py install for mozdevice 16:17:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:17:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:17:09 INFO - Running setup.py install for mozfile 16:17:09 INFO - Running setup.py install for mozhttpd 16:17:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:17:09 INFO - Running setup.py install for mozinfo 16:17:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:17:09 INFO - Running setup.py install for mozInstall 16:17:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:17:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:17:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:17:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:17:09 INFO - Running setup.py install for mozleak 16:17:09 INFO - Running setup.py install for mozlog 16:17:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:17:09 INFO - Running setup.py install for moznetwork 16:17:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:17:10 INFO - Running setup.py install for mozprocess 16:17:10 INFO - Running setup.py install for mozprofile 16:17:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:17:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:17:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:17:10 INFO - Running setup.py install for mozrunner 16:17:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:17:10 INFO - Running setup.py install for mozscreenshot 16:17:10 INFO - Running setup.py install for moztest 16:17:10 INFO - Running setup.py install for mozversion 16:17:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:17:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:17:11 INFO - Cleaning up... 16:17:11 INFO - Return code: 0 16:17:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:17:11 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')]} 16:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:11 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')]} 16:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:11 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 0x101ff3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ffa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f975aeb6dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e97d30>, '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 0x101cfbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e8eb20>, '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.kEYhwVLtHj/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.eeA7HXZwUs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 16:17:11 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 16:17:11 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 16:17:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kEYhwVLtHj/Render', 16:17:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:17:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:17:11 INFO - 'HOME': '/Users/cltbld', 16:17:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:17:11 INFO - 'LOGNAME': 'cltbld', 16:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:11 INFO - 'MOZ_NO_REMOTE': '1', 16:17:11 INFO - 'NO_EM_RESTART': '1', 16:17:11 INFO - 'PAGER': '/bin/cat', 16:17:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:11 INFO - 'PWD': '/builds/slave/test', 16:17:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:17:11 INFO - 'SHELL': '/bin/bash', 16:17:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eeA7HXZwUs/Listeners', 16:17:11 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 16:17:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:17:11 INFO - 'USER': 'cltbld', 16:17:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:17:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:11 INFO - 'XPC_FLAGS': '0x0', 16:17:11 INFO - 'XPC_SERVICE_NAME': '0', 16:17:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:17:11 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-QmuiuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:17:11 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)) 16:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:17:11 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-sBKbqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:17:11 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)) 16:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:17:11 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-1HxGYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:17:11 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)) 16:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:17:11 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-AHOd8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:17:11 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)) 16:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:17:11 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-TJ6qwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:17:11 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)) 16:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:17:11 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-s4wiIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:17:11 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)) 16:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:17:11 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-r9D56M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:17:12 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)) 16:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:17:12 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-ZCEBSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:17:12 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)) 16:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:17:12 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-coOyaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:17:12 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)) 16:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:17:12 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-x6sk2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:17:12 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)) 16:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:17:12 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-EWgwad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:17:12 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)) 16:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:17:12 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-pueVON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:17:12 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)) 16:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:17:12 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-454u9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:17:12 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)) 16:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:17:12 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-4pSszl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:17:12 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)) 16:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:17:12 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-XDMiu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:17:12 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)) 16:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:17:12 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-Ea7HFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:17:12 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)) 16:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:17:12 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-z1Mqhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:17:13 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)) 16:17:13 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)) 16:17:13 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)) 16:17:13 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)) 16:17:13 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)) 16:17:13 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)) 16:17:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:15 INFO - Downloading blessings-1.6.tar.gz 16:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:17:15 INFO - Installing collected packages: blessings 16:17:15 INFO - Running setup.py install for blessings 16:17:15 INFO - Successfully installed blessings 16:17:15 INFO - Cleaning up... 16:17:15 INFO - Return code: 0 16:17:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:17:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:17:16 INFO - Reading from file tmpfile_stdout 16:17:16 INFO - Current package versions: 16:17:16 INFO - blessings == 1.6 16:17:16 INFO - blobuploader == 1.2.4 16:17:16 INFO - docopt == 0.6.1 16:17:16 INFO - manifestparser == 1.1 16:17:16 INFO - mozInstall == 1.12 16:17:16 INFO - mozcrash == 0.17 16:17:16 INFO - mozdebug == 0.1 16:17:16 INFO - mozdevice == 0.48 16:17:16 INFO - mozfile == 1.2 16:17:16 INFO - mozhttpd == 0.7 16:17:16 INFO - mozinfo == 0.9 16:17:16 INFO - mozleak == 0.1 16:17:16 INFO - mozlog == 3.1 16:17:16 INFO - moznetwork == 0.27 16:17:16 INFO - mozprocess == 0.22 16:17:16 INFO - mozprofile == 0.28 16:17:16 INFO - mozrunner == 6.11 16:17:16 INFO - mozscreenshot == 0.1 16:17:16 INFO - mozsystemmonitor == 0.0 16:17:16 INFO - moztest == 0.7 16:17:16 INFO - mozversion == 1.4 16:17:16 INFO - psutil == 3.1.1 16:17:16 INFO - requests == 1.2.3 16:17:16 INFO - wsgiref == 0.1.2 16:17:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:17:16 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')]} 16:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:16 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')]} 16:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:16 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 0x101ff3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ffa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f975aeb6dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e97d30>, '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 0x101cfbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e8eb20>, '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.kEYhwVLtHj/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.eeA7HXZwUs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 16:17:16 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 16:17:16 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 16:17:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kEYhwVLtHj/Render', 16:17:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:17:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:17:16 INFO - 'HOME': '/Users/cltbld', 16:17:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:17:16 INFO - 'LOGNAME': 'cltbld', 16:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:16 INFO - 'MOZ_NO_REMOTE': '1', 16:17:16 INFO - 'NO_EM_RESTART': '1', 16:17:16 INFO - 'PAGER': '/bin/cat', 16:17:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:16 INFO - 'PWD': '/builds/slave/test', 16:17:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:17:16 INFO - 'SHELL': '/bin/bash', 16:17:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eeA7HXZwUs/Listeners', 16:17:16 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 16:17:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:17:16 INFO - 'USER': 'cltbld', 16:17:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:17:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:16 INFO - 'XPC_FLAGS': '0x0', 16:17:16 INFO - 'XPC_SERVICE_NAME': '0', 16:17:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:16 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)) 16:17:16 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)) 16:17:16 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)) 16:17:16 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)) 16:17:16 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)) 16:17:16 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)) 16:17:16 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)) 16:17:16 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)) 16:17:16 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)) 16:17:16 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)) 16:17:16 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)) 16:17:16 INFO - Cleaning up... 16:17:16 INFO - Return code: 0 16:17:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:17:16 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')]} 16:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:16 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')]} 16:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:16 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 0x101ff3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ffa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f975aeb6dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e97d30>, '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 0x101cfbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e8eb20>, '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.kEYhwVLtHj/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.eeA7HXZwUs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 16:17:16 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 16:17:16 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 16:17:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kEYhwVLtHj/Render', 16:17:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:17:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:17:16 INFO - 'HOME': '/Users/cltbld', 16:17:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:17:16 INFO - 'LOGNAME': 'cltbld', 16:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:16 INFO - 'MOZ_NO_REMOTE': '1', 16:17:16 INFO - 'NO_EM_RESTART': '1', 16:17:16 INFO - 'PAGER': '/bin/cat', 16:17:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:16 INFO - 'PWD': '/builds/slave/test', 16:17:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:17:16 INFO - 'SHELL': '/bin/bash', 16:17:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eeA7HXZwUs/Listeners', 16:17:16 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 16:17:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:17:16 INFO - 'USER': 'cltbld', 16:17:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:17:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:16 INFO - 'XPC_FLAGS': '0x0', 16:17:16 INFO - 'XPC_SERVICE_NAME': '0', 16:17:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:16 INFO - Downloading/unpacking jsonschema 16:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:17:18 INFO - Downloading/unpacking functools32 (from jsonschema) 16:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:19 INFO - Downloading functools32-3.2.3-2.tar.gz 16:17:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:17:19 INFO - warning: no files found matching '*.txt' 16:17:19 INFO - no previously-included directories found matching 'build' 16:17:19 INFO - no previously-included directories found matching 'dist' 16:17:19 INFO - no previously-included directories found matching '.git*' 16:17:19 INFO - Installing collected packages: jsonschema, functools32 16:17:19 INFO - Running setup.py install for functools32 16:17:19 INFO - warning: no files found matching '*.txt' 16:17:19 INFO - no previously-included directories found matching 'build' 16:17:19 INFO - no previously-included directories found matching 'dist' 16:17:19 INFO - no previously-included directories found matching '.git*' 16:17:19 INFO - Successfully installed jsonschema functools32 16:17:19 INFO - Cleaning up... 16:17:19 INFO - Return code: 0 16:17:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101ff3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ffa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f975aeb6dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e97d30>, '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 0x101cfbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e8eb20>, '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.kEYhwVLtHj/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.eeA7HXZwUs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 16:17:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:17:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kEYhwVLtHj/Render', 16:17:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:17:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:17:19 INFO - 'HOME': '/Users/cltbld', 16:17:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:17:19 INFO - 'LOGNAME': 'cltbld', 16:17:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:19 INFO - 'MOZ_NO_REMOTE': '1', 16:17:19 INFO - 'NO_EM_RESTART': '1', 16:17:19 INFO - 'PAGER': '/bin/cat', 16:17:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:17:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:19 INFO - 'PWD': '/builds/slave/test', 16:17:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:17:19 INFO - 'SHELL': '/bin/bash', 16:17:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eeA7HXZwUs/Listeners', 16:17:19 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 16:17:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:17:19 INFO - 'USER': 'cltbld', 16:17:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:17:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:17:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:19 INFO - 'XPC_FLAGS': '0x0', 16:17:19 INFO - 'XPC_SERVICE_NAME': '0', 16:17:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:19 INFO - Downloading/unpacking flake8 16:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:17:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:17:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:17:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:17:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:17:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:17:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:17:23 INFO - no previously-included directories found matching 'docs/_build' 16:17:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:17:23 INFO - Running setup.py install for pep8 16:17:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:17:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:17:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:17:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:17:23 INFO - no previously-included directories found matching 'docs/_build' 16:17:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:17:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:17:23 INFO - Cleaning up... 16:17:23 INFO - Return code: 0 16:17:23 INFO - Running post-action listener: _resource_record_post_action 16:17:23 INFO - Running post-action listener: _start_resource_monitoring 16:17:23 INFO - Starting resource monitoring. 16:17:23 INFO - ##### 16:17:23 INFO - ##### Running install step. 16:17:23 INFO - ##### 16:17:23 INFO - Running pre-action listener: _resource_record_pre_action 16:17:23 INFO - Running main action method: install 16:17:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:17:24 INFO - Reading from file tmpfile_stdout 16:17:24 INFO - Detecting whether we're running mozinstall >=1.0... 16:17:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:17:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:17:24 INFO - Reading from file tmpfile_stdout 16:17:24 INFO - Output received: 16:17:24 INFO - Usage: mozinstall [options] installer 16:17:24 INFO - Options: 16:17:24 INFO - -h, --help show this help message and exit 16:17:24 INFO - -d DEST, --destination=DEST 16:17:24 INFO - Directory to install application into. [default: 16:17:24 INFO - "/builds/slave/test"] 16:17:24 INFO - --app=APP Application being installed. [default: firefox] 16:17:24 INFO - mkdir: /builds/slave/test/build/application 16:17:24 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'] 16:17:24 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 16:17:55 INFO - Reading from file tmpfile_stdout 16:17:55 INFO - Output received: 16:17:55 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:17:55 INFO - Running post-action listener: _resource_record_post_action 16:17:55 INFO - ##### 16:17:55 INFO - ##### Running run-tests step. 16:17:55 INFO - ##### 16:17:55 INFO - Running pre-action listener: _resource_record_pre_action 16:17:55 INFO - Running main action method: run_tests 16:17:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:17:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:17:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:17:55 INFO - 2016-03-14 16:17:55.854 screenresolution[1642:7424] starting screenresolution argv=screenresolution get 16:17:55 INFO - 2016-03-14 16:17:55.857 screenresolution[1642:7424] Display 0: 1600x1200x32@60 16:17:55 INFO - 2016-03-14 16:17:55.862 screenresolution[1643:7427] starting screenresolution argv=screenresolution list 16:17:55 INFO - Available Modes on Display 0 16:17:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:17:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:17:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:17:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:17:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:17:56 INFO - Intel Iris: 16:17:56 INFO - Chipset Model: Intel Iris 16:17:56 INFO - Type: GPU 16:17:56 INFO - Bus: Built-In 16:17:56 INFO - VRAM (Dynamic, Max): 1536 MB 16:17:56 INFO - Vendor: Intel (0x8086) 16:17:56 INFO - Device ID: 0x0a2e 16:17:56 INFO - Revision ID: 0x0009 16:17:56 INFO - Displays: 16:17:56 INFO - Display: 16:17:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:17:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:17:56 INFO - Display Serial Number: 1600x1200 60 16:17:56 INFO - Main Display: Yes 16:17:56 INFO - Mirror: Off 16:17:56 INFO - Online: Yes 16:17:56 INFO - Rotation: Supported 16:17:56 INFO - Return code: 0 16:17:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:17:56 INFO - Python 2.7.3 16:17:56 INFO - Return code: 0 16:17:56 INFO - grabbing minidump binary from tooltool 16:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:56 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 0x101e97d30>, '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 0x101cfbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e8eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:17:56 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 16:17:56 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 16:17:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:17:56 INFO - Return code: 0 16:17:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:17:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:17:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:17:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:17:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:17:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:17:57 INFO - Return code: 0 16:17:57 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/OfOviVFKQx6bobI5FpZ6zQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0170', '--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 16:17:57 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/OfOviVFKQx6bobI5FpZ6zQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0170 --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 16:17:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kEYhwVLtHj/Render', 16:17:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:17:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:17:57 INFO - 'HOME': '/Users/cltbld', 16:17:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:17:57 INFO - 'LOGNAME': 'cltbld', 16:17:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:17:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:57 INFO - 'MOZ_NO_REMOTE': '1', 16:17:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:17:57 INFO - 'NO_EM_RESTART': '1', 16:17:57 INFO - 'PAGER': '/bin/cat', 16:17:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:57 INFO - 'PWD': '/builds/slave/test', 16:17:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:17:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:17:57 INFO - 'SHELL': '/bin/bash', 16:17:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eeA7HXZwUs/Listeners', 16:17:57 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 16:17:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:17:57 INFO - 'USER': 'cltbld', 16:17:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:17:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:57 INFO - 'XPC_FLAGS': '0x0', 16:17:57 INFO - 'XPC_SERVICE_NAME': '0', 16:17:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:17:57 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/OfOviVFKQx6bobI5FpZ6zQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0170', '--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 16:17:57 INFO - mozversion application_buildid: 20160314142340 16:17:57 INFO - mozversion application_changeset: 5e9097f4bf87974241e6c1673c4a5633d888f9ad 16:17:57 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:17:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:17:57 INFO - mozversion application_name: Firefox 16:17:57 INFO - mozversion application_remotingname: firefox-dev 16:17:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:17:57 INFO - mozversion application_vendor: Mozilla 16:17:57 INFO - mozversion application_version: 47.0a2 16:17:57 INFO - mozversion platform_buildid: 20160314142340 16:17:57 INFO - mozversion platform_changeset: 5e9097f4bf87974241e6c1673c4a5633d888f9ad 16:17:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:17:57 INFO - mozversion platform_version: 47.0a2 16:17:57 INFO - using testdate: 1457997477 16:17:57 INFO - actual date: 1457997477 16:17:57 INFO - starting webserver on 'localhost:49272' 16:17:57 INFO - SUITE-START | Running 2 tests 16:17:57 INFO - TEST-START | dromaeo_css 16:17:57 INFO - operating with platform_type : mac_ 16:17:57 INFO - Initialising browser for dromaeo_css test... 16:17:57 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmpZbZKWz/profile http://localhost:49272/getInfo.html) 16:17:59 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 16:17:59 INFO - PROCESS | 1661 | colorDepth:24 16:17:59 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 16:17:59 INFO - PROCESS | 1661 | __metrics 16:17:59 INFO - PROCESS | 1661 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:17:59 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:18:00 INFO - TEST-INFO | 1661: exit 0 16:18:00 INFO - Browser initialized. 16:18:00 INFO - Running cycle 1/1 for dromaeo_css test... 16:18:00 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmpZbZKWz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:18:12 INFO - PROCESS | 1663 | RSS: Main: 210436096 16:18:12 INFO - PROCESS | 1663 | 16:19:03 INFO - PROCESS | 1663 | 1457997543978 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] 16:21:14 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 16:21:15 INFO - PROCESS | 1663 | RSS: Main: 320008192 16:21:15 INFO - PROCESS | 1663 | 16:24:18 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 16:24:18 INFO - PROCESS | 1663 | RSS: Main: 347242496 16:24:18 INFO - PROCESS | 1663 | 16:27:20 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 16:27:21 INFO - PROCESS | 1663 | RSS: Main: 349851648 16:27:21 INFO - PROCESS | 1663 | 16:30:23 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 16:30:24 INFO - PROCESS | 1663 | RSS: Main: 307232768 16:30:24 INFO - PROCESS | 1663 | 16:33:27 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 16:33:27 INFO - PROCESS | 1663 | RSS: Main: 308699136 16:33:27 INFO - PROCESS | 1663 | 16:36:30 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 16:36:30 INFO - PROCESS | 1663 | RSS: Main: 355926016 16:36:30 INFO - PROCESS | 1663 | 16:36:30 INFO - PROCESS | 1663 | __start_tp_report 16:36:30 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 16:36:30 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 16:36:30 INFO - PROCESS | 1663 | |i|pagename|runs| 16:36:30 INFO - PROCESS | 1663 | |0;dojo.html;3348;3530.6822385985256;3544.0785395797084;3545.1314427965153;3585.6772890439856;5900.262467191606;5908.350081491032;5920.703964801764;5924.674142922137;5950.434708702672;5882.735276912538;5927.496162826154;5927.992241318975;5930.851728706784;5964.582479226456;5065.012322597095;5158.9742051289695;5261.210818377255;5296.205569164617;5333.57331413486;5378.0857254266675;5390.487903649167;5393.892122157555;5400.891982160354;5402.432744561824;5054.873628159288;5112.872178195537;5136.614753893473;5139.717315547643;5162.716050617215;5238.397584277819;5325.920111198335;5333.786648534054;5347.652402593819;5392.595555333366;5146.639735218499;5251.133562962144;5267.762950667229;5321.068812957717;5334.91997620036;5684.488396044376;5684.943150568482;5742.368339482654;5748.166515855178;5763.5101016413655;6207.813765586994;6316.115743795872;6326.68366581669;6337.112804207414;6340.651264180468;6241.719122639447;6272.780452684134;6310.5267104967315;6329.303776584572;6333.904991425133;6040.415290982153;6043.8186854394435;6045.395350693852;6063.575549711522;6072.696365181723;6423.518236132309;6440.13058237132;6443.48452123829;6447.903281450782;6452.709628066748;6159.137720719103;6246.843828904223;6249.593776404519;6350.174477317919;6385.233771947396;6236.251649802053;6313.179286692701;6319.0837328587095;6319.083732858801;6320.241571011416;6254.843628909222;6322.873542529215;6329.588576742497;6341.143945567382;6356.173697419398;6165.352637973038;6246.031865060922;6272.2159730033745;6284.842878928063;6285.59143655661;4263.339182426729;4823.107725070873;5013.849584512471;5019.247112933016;5052.115879721034;4465.419495465569;4476.171908196994;4486.170058539181;4494.303382975644;4508.752018639007;5761.934042202206;5854.7072646367515;5870.618409803349;5908.645481271137;5941.673207973603;6241.469475094668;6241.875162496815;6284.937150628435;6286.05709143623;6301.747930082745;5844.912326315109;5848.590598658053;5943.078822782476;5951.940480595225;5974.163617093611;5474.644148130438;5478.698671573102;5495.120780675073;5497.835064948058;5503.284573005483;6509.349065093547;6509.804705858832;6516.73933042673;6520.510961677798;6524.575902566318;6204.410580994799;6279.96860015697;6285.371462853678;6297.275813281532;6298.874022519615;6381.138546296191;6464.515161362822;6492.675366231764;6499.1876015498065;6513.348665133449;6273.74905003813;6300.905486417799;6302.401271879165;6308.873822523616;6318.304986451395;6208.50331973432;6272.498200143887;6284.937150628618;6295.276043254901;6311.842203944938;5994.520438364833;6231.345708700521;6275.278342990432;6290.748370065146;6313.589616674902;6238.376162383725;6257.56197066201;6260.906086408617;6271.3415091414745;6277.403646653561;6044.697765111815;6084.11780291864;6095.146679464967;6114.175715401237;6177.84555386119;6219.191505104308;6283.905741413791;6306.684665766602;6321.683915804283;6337.366263373626;5254.579633629224;6013.759449621966;6138.202033735586;6153.630782153085;6164.167837341902 16:36:30 INFO - PROCESS | 1663 | |1;ext.html;449.71443133610165;557.289455943672;620.3796203796204;660.6696651674163;667.9732810687573;32573.511397329028;41342;41736.58263417365;41761.16477670445;41866.790666046705;44616.3307550387;45126;45156.87107822306;45227.547724522745;45238;9704.757381065494;9916.10755032047;9925.305228633999;9930.553125109387;9935.552900119512;9765.218782497419;9911.454869982148;9911.504424778768;9911.752206194831;9929;9854.852177217348;10043.497825108752;10052.748681282954;10052.798944021115;10072;9996.90003099967;10035.74910627233;10039.89960100397;10051.346662466989;10056.648017319396;9769.51152442375;9902.405855648612;9908.256880733901;9910.752231194207;9911.008899110104;43603;43805.34291985591;43832.56167438348;43855;43866.342004869955;3268.542404063433;3344.6320904700465;3395.5076513905346;3419.6409377015552;3990.06233535119;29111.708882911113;29128;29130.563041554393;30343.089707308816;30414.239644008856;2831.844248566328;2837.6878543360212;2842.2894276430893;2912.533994560881;2939.720726530976;500741;506314;507826;509142;509197;49059.754701226266;68867;69020.6548967252;69174.65412673005;69187.30812691909;48797.75601122043;48968.265476017885;49007.75496122568;49008.754956225705;49089.754551227015;17295.654086918443;17621.55946101332;17637.470875873743;17638.470845874643;17646.91176544109;13951.930240348733;14049.22729249901;14064.648383790283;14074.366653500618;14076;16013.67972640564;16019.199040047952;16019.759703604455;16036.594510823237;16069.196540172945;6628.801135965929;6642.335766423415;6698.799036028927;6702;6715.2613212546585;942.3121121581147;1035.063267742679;1121.4280716834473;1126.571902676994;1185.6443067079842;29232.707672923;29587;29843.701562984093;30150;30185.09444716662;1078.6979645699216;1186.6973921650097;1222.358261912503;1228.7542491501736;1236.6970092327438;15146.242687865562;15240;15319.693606128038;15506.5348039559;15592.376304947902;668966;678417;685316;687132;689721;56885;67301.66349168222;68053.31946680568;68193.99999999901;68258;1402.8877689784792;1529.3041666041925;1529.7475916473657;1556.4552406657806;1556.564162034632;25761;30378.544321834746;30520.445725800713;30816.691833081382;30873.536896946116;53066.73466632642;53414.198787019006;54012.459875400746;54128.188077179664;54164.64588385322;419333;422586;423448;423796;425098;30372.84813575918;34591;35360.469592956644;35848;35926.461103082955;48965.03205477591;50377;50454.495455046446;50511.74744126256;50676;38368.2326353477;39568.80215598903;40060.1987960245;40163.97950256218;41374.37938430986;38735.41896871493;38814.6118538811;38914.6108538911;39800.80099599483;39930;39255.80372098121;39420.60579394169;39424.802875985435;39950.200995979336;40204.39693404543;34421.65578344184;34827.82586087054;34839.65160348364;35229.295414092085;35430.46854297136;26156.476870462866;26211.60682589801;26335;26512;26704.732952671002 16:36:30 INFO - PROCESS | 1663 | |2;jquery.html;337.648845200991;380.8324337291592;388.896942310288;389.3167491053201;394.81443721450944;20236.89881550592;20622.38132856015;20907.477313067142;21387.930603469802;21398.9300534973;12413.689657758561;12641.051921105907;12703.237805731662;12724.554640587581;12751.872481275184;4166.66666666666;4664.650151238654;5925.407459254083;6116.694165291718;6129.570930034899;4292.506361768405;5837.50381217597;6103.1455596216565;6105.450509454148;6108.969455152718;6075.422834830684;6079.939200608003;6093.512518998492;6106.358832322609;6354.491640668735;4128.710990230685;6505.869882602345;6516.250631177428;6522.5760325578685;6530.412262896339;5557.888842223173;5774.538036957033;5776.855578610526;5779.566532510079;5787.71061446926;13569.728605427936;13674.521391751341;13899.79150312746;14261.215633140173;14282.57152285433;2125.2763156590486;2137.465633591602;2142.678598210265;2325.8255630827757;2350.753170917046;10170.491475426199;10198.592056317739;10353.482325883675;10489.63286284984;10571.207159462994;1761.3042848074938;1783.2421220981032;1837.8713490055702;1841.4291569613463;1856.1740025688573;111226;112873;114790.70418591665;114869;115103;11873;11877.346745928884;11890;11922.390477285455;11942.820857687142;14477.276136193148;14557.85442145565;14559.92720036393;14581.416743330361;14585.270736463135;9013.18881300686;9037.77405564853;9099.545022748836;9113.589888455035;9194.95402522983;7696.191899850547;8513.19124683154;9252.121048500381;9286.90713092874;9305.53472326381;4681.648876334289;4687.718736875799;4689.343491911135;4690.742009189459;4730.574248317668;1738.268808832892;1874.6531891599825;1988.4332965104875;1991.0641998260794;2012.4264584593614;717.436812102497;757.5151902782223;811.8619834628128;953.909378609031;1039.750459889621;16773.83226167747;20496.897515512326;21074.262400815896;21186.576268474546;21449.892750536146;975;990.9653162139291;993.8111758765812;1039.8024375368657;1107.64001699448;8936.642534298686;11302.208845380908;11318.886811131948;11341.489632966537;11344.659660210207;666079;670081;677465;697077;701715;111158.44420778006;113062;116343;122491.55016899612;123813.38093309656;1042.6611351310855;1054.3568423261804;1060.570468960057;1070.1064611049705;1071.23406764164;17569.736453952944;18073.548161296072;18341.3580524681;18536.351227706964;18609.627807444045;40561.59438405696;47581;49582.25626615676;49847.75076124596;50727.985440291726;73012;73076;74688;75326.87927672153;76083.85874211781;8032.759017229492;8287.212714792086;8417;8418.368622353226;8424.915750842412;9435.622575096919;13320.000999925238;13321.800172997218;13400.195988240737;13863.653408664864;7725.459217854696;11530.481128349076;11819.349935753617;11908.523659053888;11987.580434684744;11549.595764148215;11593.6521904343;11600.825987610024;11728.41357932117;11819.527218911147;10052.39685618836;11044.558217671203;11633.836616338298;11860.288382697066;11949.342786146497;8206.179382061746;8309.04445988719;8357.791055223668;8570.74287771368;8577.313814894918;11405.087592992375;11580.652580422264;11694.181407301407;11925;12000.519979201083 16:36:30 INFO - PROCESS | 1663 | |3;mootools.html;1502.8196616406033;1607.1642745772197;1663.62568422105;2013.7382140321756;2106.8314534837214;8434.746957591275;8966.417182883108;9173.403728757627;9174.541272936343;9191.908080919196;9037.367384283103;9308.813823723522;9311.95344023279;9314.813703725922;9322.067793220675;2036.1346427768212;2283.235116236063;2385.475195457005;2537.5559277126476;2567.679040119985;2446.8409553378974;2450.754924507553;2453.264020793764;2455.3370589940705;2457.066314800373;2161.7622061573215;2448.698910692753;2592.520383729007;2593.6757905261843;2593.844369337846;2532.6813691248417;2560.513502434541;2603.5183491054217;2614.2157352794084;2614.673165854268;2533.2147034419204;2571.6785401824773;2583.2379448062866;2585.250277419546;2586.5473542130053;9272;9335.626574936994;9337.533123343806;9338.439693618404;9346.532673366304;5667.858303542444;5781.884362312772;5810.535157187415;5848.561357898132;5874.676892770896;3662.285854258421;3748.306563285801;3799.2781371539595;3810.123671555558;3815.1606646537716;1058.5395353021383;1066.5040756048475;1074.135321066541;1089.8528698625664;1111.2221444988459;12810.911072558843;12822.743545129139;12824.038197135158;12832.615021549369;12848.614541563767;5087.771050302671;5125.666831655931;5234.502722241381;5235.188545775411;5252.65857719247;10710.303830251165;10721;10739.463026848782;10755.354678719146;10758.139348852073;5805.506531944748;5844.561657875676;5846.883062338729;5847.619904706181;5853.707314634251;4688.601468875184;5063.721495317793;5182.637215394886;5240.502152295526;5250.894982100413;4061.8375264989068;4069.8168582413864;4091.1408604192857;4095.2833254180996;4145.854895078658;1178.911581631381;1238.9566365177175;1370.0683535195963;1376.9586912392645;1380.323641415719;1251.1867286264;1273.6433798536425;1396.1692792788274;1440.6038339456525;1444.3572610188576;7266.854662906818;8560.0583935767;8618.138186181332;8635.78410539729;8650.178233067849;1145.5131569083105;1258.3016425883538;1272.166730791333;1272.2557303977278;1275.8787915148046;6435.195600549931;6537.280899101095;6620.337966203438;6621.768238111643;6624.8012559623285;10965.232433729563;11228.101751859831;11281.32312061279;11312.264702794457;11383.260088094248;10615;10908.945455272673;10964.342139471657;11212.215144939775;11231.315302704495;8660.78348041304;8807.559622018873;8830.161134692322;8893.688720894737;8902.109789021046;8231.176882311722;8558.743237702878;8576.356773241907;8578.442401244149;8589.613467393858;9676.371035882645;9888.406695598287;9983.950080249553;10136.290459667753;10187.643432479828;10202.132818710492;10269.229807764297;10638;10664.466776661291;10876.728081798019;7223.638818058971;7440.813979650552;7699.807504812425;7949.8410031800195;8066.274035336848;8704;8734.432261902955;8766.956165219133;8773.692920747742;8790.857188565446;7637.656305466378;7695.730649427467;7760.611969401621;7874.960625197066;7883.172266911892;7507.474476786572;7537.057867766529;7550.7734767957045;7651.693932242648;7736.651850666621;8036.437449378487;8197.385196110436;8212.30195433371;8220.547869867214;8221.79445513843;7302.598357090411;7446.7021319146625;7458.73894413693;7478.738244161428;7500.249975002456;7509.098908131059;7510.211427800003;7560.243975602396;7571.507851989603;7593.506422082547 16:36:30 INFO - PROCESS | 1663 | |4;prototype.html;339.60436091952874;347.53603938741793;351.89091381671676;352.2356486424459;358.9605143434222;6562.835929101775;6564;6624.5694029888145;6667.399934005938;6688.832779180523;5405.945840561092;6573.539852210347;6578.2106147262275;6589.934100658992;6591.077249185118;4048.2308361411383;4764.499727528611;4813.59084477818;4874.756262186894;4976.178930476467;4968.3292755477905;4986.626003049786;4990.151674215392;4996.525330093636;5007.198848184291;4056.3509838425857;4967.155583550787;4967.379077615298;4976.576990955773;4985.950140498603;4715.339852420664;4793.880152996186;4871.951280487186;4911.336969509106;4921.212605983025;4236.830526778926;4241.130568233505;4242.4272723182285;4250.978745106286;4257.19113368459;6390.9360906391275;6419.5506314558;6430.646314452703;6438.8390290243115;6441.194850643669;5822.592418530662;5903.291605007384;5918.911216331759;5921.141434491975;5926.97036514819;5969.820905372802;6837.418819400357;7108.964455177743;7121.465890058266;7141.571505709674;4638.8608341749805;4797.712137271775;4828.73441960692;4829.034193161347;4831;6428.550001499897;7438.516496427715;7442.032535770423;7457.552546847207;7460.850782984364;4876.634252431082;4883.487233840396;4885;4885.926711099336;4886.53577910098;4954.578860796801;4956.925646115311;4960;4970.627202959792;4979.979104283613;5688;5848;5875.912956103135;5887.558433117533;5889.469947704727;7065.505414620927;7113.82215444618;7113.928860711327;7123.964380178066;7125.82185445368;1390.32569203936;1451.7822326650876;1740.4256595323513;1742.9041402722971;1745.2233755978468;1060.4273692206277;1103.6082190822142;1121.786860496503;1134.4214450630072;1154.7459558897028;5469.453054694499;6478.740850365933;6647.1026411434805;6656.36764507371;6674;7438.851222975511;7438.962805186047;7444.516106453171;7450.143233528105;7458.813529661693;6645.302243264484;6649.3018233085795;6650.9667451662435;6651.86696266072;6658.700358483879;3760.8119594020736;3882.708796840192;3912.374020156761;3916.334223182009;3916.8433262669746;7677.577733224614;7678.577678227751;7680.923190768132;7692.230776922263;7698.92301076982;7546.094468663796;7600.315971562475;7606.201348858401;7611.048618922635;7616.971708819238;7660.846783064308;7670.731524396842;7674.961625191839;7676.692932282758;7678.808029799188;7104;7328.78013659591;7390.852182956418;7401.296876796696;7401.851962960818;7214.783556493314;7225.132984041738;7256.891146632699;7269.7455589054125;7301.306375894282;7678;7680.155182929761;7684.462087654034;7689.461737678533;7694.461387702807;3947.9407808882315;4699.060187962353;4757.858114052533;4758.333833263415;4763.237881938873;6063.181470501426;7089.397401220954;7376.7786966391095;7391.039164908528;7395.7041718330665;5743.3395159557185;7157.57054576727;7166.283371662792;7167.784966451015;7173.175084865307;7027.01621772942;7112.0754301940415;7130.500864939404;7135.322144396274;7142.535735177197;5850.268716410449;6980;6984.3364880336285;6996.160460744743;7003.859922801414;6889.207741109836;7106.040684507525;7141.143062832493;7145.17830449505;7165;6802.8639427212165;6846.965765171142;6965.199002114821;6989.825254368681;6999.230084690578 16:36:30 INFO - PROCESS | 1663 | |5;yui.html;672.153087110241;694.5971336624758;733.2154594583794;753.2806170107548;770.1066762555437;12054.939725301372;15307.081575105474;15489.457868974589;15511.689766204669;15536.611584710374;12590.118691691585;14009.299535023234;14529.636759081002;14531.709365812678;14566.708665826676;975.9219262459022;1015.5024038221293;1028.115820394464;1033.0650761061252;1039.215392378753;824.826786374862;830.6511265268601;1021.9386836789779;1037.066640023977;1049.574922156524;1076.214363514635;1078.8867168947265;1082.3289560472517;1083.0685610375072;1084.7233955341376;1068.8877667844843;1070.8019016481937;1071.4535586850684;1076.1122074288744;1078.7896360209763;645.5771469687362;654.8362909272682;798.2855344466727;812.5530957973091;819.4550623835142;15469.922650386789;15482.22588870552;15499.5350139496;15506.379744810194;15525.378984840592;11114.166437517139;11249.775004499947;11386.487608057658;11498.965093141658;11540.884591154065;9176.08239176077;10087.445190514518;10208.234382421348;10292.228082893813;10924.836127458095;3477.196752626543;3518.313928783888;3526.3828829954914;3602.7838329700303;3782;82996;85931;86160.7075893862;86514;92716;9879.703608891745;10027.298089133836;10046.397216166908;10315.432651204255;10924.617638382619;23139.190128345763;23340.183093591982;23431.179908703114;23833.04667813303;23881.7611823883;7794.10367807698;7837.882431763528;8015.238552337519;8032.879506807402;8096.149904259968;4199.286121359315;4214.17823524416;4253.787310634456;4266.6160045595425;4347.5217726050105;3659.70722342212;3748.231612519427;3750.9437358439645;3809.9809500952874;3851.557070936878;703.1702590942634;719.3633634233636;725.408791834653;737.2406421385981;739.4306384084225;492.2198315669632;511.68275669085403;570.5350139636183;572.6936089192345;588.6674029173589;8119.350451963829;8119.83760324802;8129.715459958873;8174.223448772357;8310.584470776557;534.4468475128224;592.6769910398843;600.2047287344286;604.1330690459205;607.3562024254304;3757.94777462311;3854.8843534694006;3872.7482713623526;3896.7272290939927;3902.0635047588944;90689.63965540522;95007;95860;95978;96126;78510.6074469624;81882.3623527526;81975.7703634446;82771.17228827755;82894.58552707198;71466.92799607906;71549.6422517884;71899;72517.6374118126;72537.6373118131;7638.732644357421;7776.572288524186;7834.725784597512;7905.051393832547;8060.566240592606;39320.80339598284;49348.75325623349;49622.75188624034;50178.498215018844;50518.49481505285;64358.71282574416;64415;65129.02306465502;65972.00838357784;66206;10064.144547713233;10190.184785217312;10194.490275486047;10374.844377334195;10912.781744365227;10511.316764410289;10609.363438193734;10735.194860385345;10921.945390272998;11483.8277425837;10123.544440500342;10218.846717299395;10322.690319290434;10428.374297542172;11046.447677615926;10155.289129760846;10256.12822910061;10389.37663740178;10491.790164196826;10499.94750026245;9954.601815927572;9980.900190997998;10038.949805250926;10165.745856353651;10178.491075446345;8545.786355341166;8653.870191947251;8732.956335218283;8793.164649358556;9008.369414141209;8809.955950220208;8898.55507224649;8978.461292322481;9141.63433462654;9298.581563829508 16:36:30 INFO - PROCESS | 1663 | __end_tp_report 16:36:30 INFO - PROCESS | 1663 | __start_cc_report 16:36:30 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,917 16:36:30 INFO - PROCESS | 1663 | __end_cc_report 16:36:30 INFO - PROCESS | 1663 | __startTimestamp1457998590470__endTimestamp 16:36:30 INFO - PROCESS | 1663 | 16:36:30 INFO - PROCESS | 1663 | ------- Summary: start ------- 16:36:30 INFO - PROCESS | 1663 | Number of tests: 6 16:36:30 INFO - PROCESS | 1663 | 16:36:30 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5854.02 Median:6138.20 stddev:659.56 (10.7%) stddev-sans-first:631.60 16:36:30 INFO - PROCESS | 1663 | Values: 3348.0 3530.7 3544.1 3545.1 3585.7 5900.3 5908.4 5920.7 5924.7 5950.4 5882.7 5927.5 5928.0 5930.9 5964.6 5065.0 5159.0 5261.2 5296.2 5333.6 5378.1 5390.5 5393.9 5400.9 5402.4 5054.9 5112.9 5136.6 5139.7 5162.7 5238.4 5325.9 5333.8 5347.7 5392.6 5146.6 5251.1 5267.8 5321.1 5334.9 5684.5 5684.9 5742.4 5748.2 5763.5 6207.8 6316.1 6326.7 6337.1 6340.7 6241.7 6272.8 6310.5 6329.3 6333.9 6040.4 6043.8 6045.4 6063.6 6072.7 6423.5 6440.1 6443.5 6447.9 6452.7 6159.1 6246.8 6249.6 6350.2 6385.2 6236.3 6313.2 6319.1 6319.1 6320.2 6254.8 6322.9 6329.6 6341.1 6356.2 6165.4 6246.0 6272.2 6284.8 6285.6 4263.3 4823.1 5013.8 5019.2 5052.1 4465.4 4476.2 4486.2 4494.3 4508.8 5761.9 5854.7 5870.6 5908.6 5941.7 6241.5 6241.9 6284.9 6286.1 6301.7 5844.9 5848.6 5943.1 5951.9 5974.2 5474.6 5478.7 5495.1 5497.8 5503.3 6509.3 6509.8 6516.7 6520.5 6524.6 6204.4 6280.0 6285.4 6297.3 6298.9 6381.1 6464.5 6492.7 6499.2 6513.3 6273.7 6300.9 6302.4 6308.9 6318.3 6208.5 6272.5 6284.9 6295.3 6311.8 5994.5 6231.3 6275.3 6290.7 6313.6 6238.4 6257.6 6260.9 6271.3 6277.4 6044.7 6084.1 6095.1 6114.2 6177.8 6219.2 6283.9 6306.7 6321.7 6337.4 5254.6 6013.8 6138.2 6153.6 6164.2 16:36:30 INFO - PROCESS | 1663 | 16:36:30 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:68267.22 Median:21895.43 stddev:146353.54 (668.4%) stddev-sans-first:146675.52 16:36:30 INFO - PROCESS | 1663 | Values: 449.7 557.3 620.4 660.7 668.0 32573.5 41342.0 41736.6 41761.2 41866.8 44616.3 45126.0 45156.9 45227.5 45238.0 9704.8 9916.1 9925.3 9930.6 9935.6 9765.2 9911.5 9911.5 9911.8 9929.0 9854.9 10043.5 10052.7 10052.8 10072.0 9996.9 10035.7 10039.9 10051.3 10056.6 9769.5 9902.4 9908.3 9910.8 9911.0 43603.0 43805.3 43832.6 43855.0 43866.3 3268.5 3344.6 3395.5 3419.6 3990.1 29111.7 29128.0 29130.6 30343.1 30414.2 2831.8 2837.7 2842.3 2912.5 2939.7 500741.0 506314.0 507826.0 509142.0 509197.0 49059.8 68867.0 69020.7 69174.7 69187.3 48797.8 48968.3 49007.8 49008.8 49089.8 17295.7 17621.6 17637.5 17638.5 17646.9 13951.9 14049.2 14064.6 14074.4 14076.0 16013.7 16019.2 16019.8 16036.6 16069.2 6628.8 6642.3 6698.8 6702.0 6715.3 942.3 1035.1 1121.4 1126.6 1185.6 29232.7 29587.0 29843.7 30150.0 30185.1 1078.7 1186.7 1222.4 1228.8 1236.7 15146.2 15240.0 15319.7 15506.5 15592.4 668966.0 678417.0 685316.0 687132.0 689721.0 56885.0 67301.7 68053.3 68194.0 68258.0 1402.9 1529.3 1529.7 1556.5 1556.6 25761.0 30378.5 30520.4 30816.7 30873.5 53066.7 53414.2 54012.5 54128.2 54164.6 419333.0 422586.0 423448.0 423796.0 425098.0 30372.8 34591.0 35360.5 35848.0 35926.5 48965.0 50377.0 50454.5 50511.7 50676.0 38368.2 39568.8 40060.2 40164.0 41374.4 38735.4 38814.6 38914.6 39800.8 39930.0 39255.8 39420.6 39424.8 39950.2 40204.4 34421.7 34827.8 34839.7 35229.3 35430.5 26156.5 26211.6 26335.0 26512.0 26704.7 16:36:30 INFO - PROCESS | 1663 | 16:36:30 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:36256.93 Median:21130.42 stddev:112928.54 (534.4%) stddev-sans-first:113213.13 16:36:30 INFO - PROCESS | 1663 | Values: 337.6 380.8 388.9 389.3 394.8 20236.9 20622.4 20907.5 21387.9 21398.9 12413.7 12641.1 12703.2 12724.6 12751.9 4166.7 4664.7 5925.4 6116.7 6129.6 4292.5 5837.5 6103.1 6105.5 6109.0 6075.4 6079.9 6093.5 6106.4 6354.5 4128.7 6505.9 6516.3 6522.6 6530.4 5557.9 5774.5 5776.9 5779.6 5787.7 13569.7 13674.5 13899.8 14261.2 14282.6 2125.3 2137.5 2142.7 2325.8 2350.8 10170.5 10198.6 10353.5 10489.6 10571.2 1761.3 1783.2 1837.9 1841.4 1856.2 111226.0 112873.0 114790.7 114869.0 115103.0 11873.0 11877.3 11890.0 11922.4 11942.8 14477.3 14557.9 14559.9 14581.4 14585.3 9013.2 9037.8 9099.5 9113.6 9195.0 7696.2 8513.2 9252.1 9286.9 9305.5 4681.6 4687.7 4689.3 4690.7 4730.6 1738.3 1874.7 1988.4 1991.1 2012.4 717.4 757.5 811.9 953.9 1039.8 16773.8 20496.9 21074.3 21186.6 21449.9 975.0 991.0 993.8 1039.8 1107.6 8936.6 11302.2 11318.9 11341.5 11344.7 666079.0 670081.0 677465.0 697077.0 701715.0 111158.4 113062.0 116343.0 122491.6 123813.4 1042.7 1054.4 1060.6 1070.1 1071.2 17569.7 18073.5 18341.4 18536.4 18609.6 40561.6 47581.0 49582.3 49847.8 50728.0 73012.0 73076.0 74688.0 75326.9 76083.9 8032.8 8287.2 8417.0 8418.4 8424.9 9435.6 13320.0 13321.8 13400.2 13863.7 7725.5 11530.5 11819.3 11908.5 11987.6 11549.6 11593.7 11600.8 11728.4 11819.5 10052.4 11044.6 11633.8 11860.3 11949.3 8206.2 8309.0 8357.8 8570.7 8577.3 11405.1 11580.7 11694.2 11925.0 12000.5 16:36:30 INFO - PROCESS | 1663 | 16:36:30 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:6390.45 Median:5154.15 stddev:3380.03 (65.6%) stddev-sans-first:3369.54 16:36:30 INFO - PROCESS | 1663 | Values: 1502.8 1607.2 1663.6 2013.7 2106.8 8434.7 8966.4 9173.4 9174.5 9191.9 9037.4 9308.8 9312.0 9314.8 9322.1 2036.1 2283.2 2385.5 2537.6 2567.7 2446.8 2450.8 2453.3 2455.3 2457.1 2161.8 2448.7 2592.5 2593.7 2593.8 2532.7 2560.5 2603.5 2614.2 2614.7 2533.2 2571.7 2583.2 2585.3 2586.5 9272.0 9335.6 9337.5 9338.4 9346.5 5667.9 5781.9 5810.5 5848.6 5874.7 3662.3 3748.3 3799.3 3810.1 3815.2 1058.5 1066.5 1074.1 1089.9 1111.2 12810.9 12822.7 12824.0 12832.6 12848.6 5087.8 5125.7 5234.5 5235.2 5252.7 10710.3 10721.0 10739.5 10755.4 10758.1 5805.5 5844.6 5846.9 5847.6 5853.7 4688.6 5063.7 5182.6 5240.5 5250.9 4061.8 4069.8 4091.1 4095.3 4145.9 1178.9 1239.0 1370.1 1377.0 1380.3 1251.2 1273.6 1396.2 1440.6 1444.4 7266.9 8560.1 8618.1 8635.8 8650.2 1145.5 1258.3 1272.2 1272.3 1275.9 6435.2 6537.3 6620.3 6621.8 6624.8 10965.2 11228.1 11281.3 11312.3 11383.3 10615.0 10908.9 10964.3 11212.2 11231.3 8660.8 8807.6 8830.2 8893.7 8902.1 8231.2 8558.7 8576.4 8578.4 8589.6 9676.4 9888.4 9984.0 10136.3 10187.6 10202.1 10269.2 10638.0 10664.5 10876.7 7223.6 7440.8 7699.8 7949.8 8066.3 8704.0 8734.4 8767.0 8773.7 8790.9 7637.7 7695.7 7760.6 7875.0 7883.2 7507.5 7537.1 7550.8 7651.7 7736.7 8036.4 8197.4 8212.3 8220.5 8221.8 7302.6 7446.7 7458.7 7478.7 7500.2 7509.1 7510.2 7560.2 7571.5 7593.5 16:36:30 INFO - PROCESS | 1663 | 16:36:30 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:5821.89 Median:6575.88 stddev:1844.43 (28.0%) stddev-sans-first:1803.12 16:36:30 INFO - PROCESS | 1663 | Values: 339.6 347.5 351.9 352.2 359.0 6562.8 6564.0 6624.6 6667.4 6688.8 5405.9 6573.5 6578.2 6589.9 6591.1 4048.2 4764.5 4813.6 4874.8 4976.2 4968.3 4986.6 4990.2 4996.5 5007.2 4056.4 4967.2 4967.4 4976.6 4986.0 4715.3 4793.9 4872.0 4911.3 4921.2 4236.8 4241.1 4242.4 4251.0 4257.2 6390.9 6419.6 6430.6 6438.8 6441.2 5822.6 5903.3 5918.9 5921.1 5927.0 5969.8 6837.4 7109.0 7121.5 7141.6 4638.9 4797.7 4828.7 4829.0 4831.0 6428.6 7438.5 7442.0 7457.6 7460.9 4876.6 4883.5 4885.0 4885.9 4886.5 4954.6 4956.9 4960.0 4970.6 4980.0 5688.0 5848.0 5875.9 5887.6 5889.5 7065.5 7113.8 7113.9 7124.0 7125.8 1390.3 1451.8 1740.4 1742.9 1745.2 1060.4 1103.6 1121.8 1134.4 1154.7 5469.5 6478.7 6647.1 6656.4 6674.0 7438.9 7439.0 7444.5 7450.1 7458.8 6645.3 6649.3 6651.0 6651.9 6658.7 3760.8 3882.7 3912.4 3916.3 3916.8 7677.6 7678.6 7680.9 7692.2 7698.9 7546.1 7600.3 7606.2 7611.0 7617.0 7660.8 7670.7 7675.0 7676.7 7678.8 7104.0 7328.8 7390.9 7401.3 7401.9 7214.8 7225.1 7256.9 7269.7 7301.3 7678.0 7680.2 7684.5 7689.5 7694.5 3947.9 4699.1 4757.9 4758.3 4763.2 6063.2 7089.4 7376.8 7391.0 7395.7 5743.3 7157.6 7166.3 7167.8 7173.2 7027.0 7112.1 7130.5 7135.3 7142.5 5850.3 6980.0 6984.3 6996.2 7003.9 6889.2 7106.0 7141.1 7145.2 7165.0 6802.9 6847.0 6965.2 6989.8 6999.2 16:36:30 INFO - PROCESS | 1663 | 16:36:30 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:18458.29 Median:4233.98 stddev:26519.74 (626.4%) stddev-sans-first:26560.51 16:36:30 INFO - PROCESS | 1663 | Values: 672.2 694.6 733.2 753.3 770.1 12054.9 15307.1 15489.5 15511.7 15536.6 12590.1 14009.3 14529.6 14531.7 14566.7 975.9 1015.5 1028.1 1033.1 1039.2 824.8 830.7 1021.9 1037.1 1049.6 1076.2 1078.9 1082.3 1083.1 1084.7 1068.9 1070.8 1071.5 1076.1 1078.8 645.6 654.8 798.3 812.6 819.5 15469.9 15482.2 15499.5 15506.4 15525.4 11114.2 11249.8 11386.5 11499.0 11540.9 9176.1 10087.4 10208.2 10292.2 10924.8 3477.2 3518.3 3526.4 3602.8 3782.0 82996.0 85931.0 86160.7 86514.0 92716.0 9879.7 10027.3 10046.4 10315.4 10924.6 23139.2 23340.2 23431.2 23833.0 23881.8 7794.1 7837.9 8015.2 8032.9 8096.1 4199.3 4214.2 4253.8 4266.6 4347.5 3659.7 3748.2 3750.9 3810.0 3851.6 703.2 719.4 725.4 737.2 739.4 492.2 511.7 570.5 572.7 588.7 8119.4 8119.8 8129.7 8174.2 8310.6 534.4 592.7 600.2 604.1 607.4 3757.9 3854.9 3872.7 3896.7 3902.1 90689.6 95007.0 95860.0 95978.0 96126.0 78510.6 81882.4 81975.8 82771.2 82894.6 71466.9 71549.6 71899.0 72517.6 72537.6 7638.7 7776.6 7834.7 7905.1 8060.6 39320.8 49348.8 49622.8 50178.5 50518.5 64358.7 64415.0 65129.0 65972.0 66206.0 10064.1 10190.2 10194.5 10374.8 10912.8 10511.3 10609.4 10735.2 10921.9 11483.8 10123.5 10218.8 10322.7 10428.4 11046.4 10155.3 10256.1 10389.4 10491.8 10499.9 9954.6 9980.9 10038.9 10165.7 10178.5 8545.8 8653.9 8733.0 8793.2 9008.4 8810.0 8898.6 8978.5 9141.6 9298.6 16:36:30 INFO - PROCESS | 1663 | -------- Summary: end -------- 16:36:30 INFO - PROCESS | 1663 | 16:36:31 INFO - TEST-INFO | 1663: exit 0 16:36:31 INFO - TEST-OK | dromaeo_css | took 1113432ms 16:36:31 INFO - TEST-START | kraken 16:36:31 INFO - operating with platform_type : mac_ 16:36:31 INFO - Initialising browser for kraken test... 16:36:31 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmp5c7ZAn/profile http://localhost:49272/getInfo.html) 16:36:33 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 16:36:33 INFO - PROCESS | 1674 | colorDepth:24 16:36:33 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 16:36:33 INFO - PROCESS | 1674 | __metrics 16:36:33 INFO - PROCESS | 1674 | 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" 16:36:33 INFO - PROCESS | 1674 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:36:34 INFO - TEST-INFO | 1674: exit 0 16:36:34 INFO - Browser initialized. 16:36:34 INFO - Running cycle 1/1 for kraken test... 16:36:34 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmp5c7ZAn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:36:45 INFO - PROCESS | 1676 | RSS: Main: 210821120 16:36:45 INFO - PROCESS | 1676 | 16:36:48 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 16:36:49 INFO - PROCESS | 1676 | RSS: Main: 266452992 16:36:49 INFO - PROCESS | 1676 | 16:36:51 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 16:36:52 INFO - PROCESS | 1676 | RSS: Main: 276656128 16:36:52 INFO - PROCESS | 1676 | 16:36:55 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 16:36:55 INFO - PROCESS | 1676 | RSS: Main: 265773056 16:36:55 INFO - PROCESS | 1676 | 16:36:57 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 16:36:58 INFO - PROCESS | 1676 | RSS: Main: 266543104 16:36:58 INFO - PROCESS | 1676 | 16:37:00 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:37:01 INFO - PROCESS | 1676 | RSS: Main: 266702848 16:37:01 INFO - PROCESS | 1676 | 16:37:03 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 16:37:04 INFO - PROCESS | 1676 | RSS: Main: 268972032 16:37:04 INFO - PROCESS | 1676 | 16:37:07 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 16:37:07 INFO - PROCESS | 1676 | RSS: Main: 267927552 16:37:07 INFO - PROCESS | 1676 | 16:37:10 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 16:37:10 INFO - PROCESS | 1676 | RSS: Main: 267309056 16:37:10 INFO - PROCESS | 1676 | 16:37:12 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:37:13 INFO - PROCESS | 1676 | RSS: Main: 302063616 16:37:13 INFO - PROCESS | 1676 | 16:37:14 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:37:15 INFO - PROCESS | 1676 | RSS: Main: 302428160 16:37:15 INFO - PROCESS | 1676 | 16:37:17 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:37:18 INFO - PROCESS | 1676 | RSS: Main: 308998144 16:37:18 INFO - PROCESS | 1676 | 16:37:20 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:37:21 INFO - PROCESS | 1676 | RSS: Main: 310198272 16:37:21 INFO - PROCESS | 1676 | 16:37:23 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:37:24 INFO - PROCESS | 1676 | RSS: Main: 310202368 16:37:24 INFO - PROCESS | 1676 | 16:37:26 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 16:37:26 INFO - PROCESS | 1676 | RSS: Main: 370098176 16:37:26 INFO - PROCESS | 1676 | 16:37:26 INFO - PROCESS | 1676 | __start_tp_report 16:37:26 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 16:37:26 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 16:37:26 INFO - PROCESS | 1676 | |i|pagename|runs| 16:37:26 INFO - PROCESS | 1676 | |0;ai-astar;111;107;110;111;112;112;119;113;111;110 16:37:26 INFO - PROCESS | 1676 | |1;audio-beat-detection;151;119;141;155;117;136;116;149;144;117 16:37:26 INFO - PROCESS | 1676 | |2;audio-dft;178;182;184;185;182;183;182;181;184;185 16:37:26 INFO - PROCESS | 1676 | |3;audio-fft;73;75;74;115;58;81;79;58;118;55 16:37:26 INFO - PROCESS | 1676 | |4;audio-oscillator;85;91;132;77;78;85;121;76;79;101 16:37:26 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;86;84;86;85;87;84;87;84;86;83 16:37:26 INFO - PROCESS | 1676 | |6;imaging-darkroom;93;92;92;92;91;92;93;92;92;92 16:37:26 INFO - PROCESS | 1676 | |7;imaging-desaturate;83;85;84;85;87;83;87;83;84;101 16:37:26 INFO - PROCESS | 1676 | |8;json-parse-financial;55;57;58;57;59;59;57;68;55;53 16:37:26 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;62;62;76;72;68;67;65;65;67;67 16:37:26 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;81;79;79;80;80;79;77;97;105;116 16:37:26 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;133;121;127;111;118;135;122;126;122;130 16:37:26 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;133;120;131;126;136;132;133;160;162;131 16:37:26 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;66;66;66;66;66;66;65;66;67;86 16:37:26 INFO - PROCESS | 1676 | __end_tp_report 16:37:26 INFO - PROCESS | 1676 | __start_cc_report 16:37:26 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1187 16:37:26 INFO - PROCESS | 1676 | __end_cc_report 16:37:26 INFO - PROCESS | 1676 | __startTimestamp1457998646381__endTimestamp 16:37:26 INFO - PROCESS | 1676 | 16:37:26 INFO - PROCESS | 1676 | ------- Summary: start ------- 16:37:26 INFO - PROCESS | 1676 | Number of tests: 14 16:37:26 INFO - PROCESS | 1676 | 16:37:26 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:111.60 Median:111.50 stddev:3.06 (2.7%) stddev-sans-first:3.24 16:37:26 INFO - PROCESS | 1676 | Values: 111.0 107.0 110.0 111.0 112.0 112.0 119.0 113.0 111.0 110.0 16:37:26 INFO - PROCESS | 1676 | 16:37:26 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:142.50 stddev:15.75 (11.1%) stddev-sans-first:15.53 16:37:26 INFO - PROCESS | 1676 | Values: 151.0 119.0 141.0 155.0 117.0 136.0 116.0 149.0 144.0 117.0 16:37:26 INFO - PROCESS | 1676 | 16:37:26 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:182.60 Median:183.50 stddev:2.12 (1.2%) stddev-sans-first:1.45 16:37:26 INFO - PROCESS | 1676 | Values: 178.0 182.0 184.0 185.0 182.0 183.0 182.0 181.0 184.0 185.0 16:37:26 INFO - PROCESS | 1676 | 16:37:26 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:78.60 Median:73.50 stddev:22.00 (29.9%) stddev-sans-first:23.24 16:37:26 INFO - PROCESS | 1676 | Values: 73.0 75.0 74.0 115.0 58.0 81.0 79.0 58.0 118.0 55.0 16:37:26 INFO - PROCESS | 1676 | 16:37:26 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:78.50 stddev:19.62 (25.0%) stddev-sans-first:20.62 16:37:26 INFO - PROCESS | 1676 | Values: 85.0 91.0 132.0 77.0 78.0 85.0 121.0 76.0 79.0 101.0 16:37:26 INFO - PROCESS | 1676 | 16:37:26 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:85.20 Median:86.00 stddev:1.40 (1.6%) stddev-sans-first:1.45 16:37:26 INFO - PROCESS | 1676 | Values: 86.0 84.0 86.0 85.0 87.0 84.0 87.0 84.0 86.0 83.0 16:37:26 INFO - PROCESS | 1676 | 16:37:26 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:92.10 Median:92.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 16:37:26 INFO - PROCESS | 1676 | Values: 93.0 92.0 92.0 92.0 91.0 92.0 93.0 92.0 92.0 92.0 16:37:26 INFO - PROCESS | 1676 | 16:37:26 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:84.50 stddev:5.41 (6.4%) stddev-sans-first:5.61 16:37:26 INFO - PROCESS | 1676 | Values: 83.0 85.0 84.0 85.0 87.0 83.0 87.0 83.0 84.0 101.0 16:37:26 INFO - PROCESS | 1676 | 16:37:26 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:57.50 stddev:4.05 (7.0%) stddev-sans-first:4.17 16:37:26 INFO - PROCESS | 1676 | Values: 55.0 57.0 58.0 57.0 59.0 59.0 57.0 68.0 55.0 53.0 16:37:26 INFO - PROCESS | 1676 | 16:37:26 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:4.28 (6.4%) stddev-sans-first:4.12 16:37:26 INFO - PROCESS | 1676 | Values: 62.0 62.0 76.0 72.0 68.0 67.0 65.0 65.0 67.0 67.0 16:37:26 INFO - PROCESS | 1676 | 16:37:26 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:79.50 stddev:13.70 (17.2%) stddev-sans-first:14.34 16:37:26 INFO - PROCESS | 1676 | Values: 81.0 79.0 79.0 80.0 80.0 79.0 77.0 97.0 105.0 116.0 16:37:26 INFO - PROCESS | 1676 | 16:37:26 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:126.50 stddev:7.23 (5.7%) stddev-sans-first:6.98 16:37:26 INFO - PROCESS | 1676 | Values: 133.0 121.0 127.0 111.0 118.0 135.0 122.0 126.0 122.0 130.0 16:37:26 INFO - PROCESS | 1676 | 16:37:26 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.40 Median:133.00 stddev:13.70 (10.3%) stddev-sans-first:14.48 16:37:26 INFO - PROCESS | 1676 | Values: 133.0 120.0 131.0 126.0 136.0 132.0 133.0 160.0 162.0 131.0 16:37:26 INFO - PROCESS | 1676 | 16:37:26 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:66.00 stddev:6.34 (9.6%) stddev-sans-first:6.69 16:37:26 INFO - PROCESS | 1676 | Values: 66.0 66.0 66.0 66.0 66.0 66.0 65.0 66.0 67.0 86.0 16:37:26 INFO - PROCESS | 1676 | -------- Summary: end -------- 16:37:26 INFO - PROCESS | 1676 | 16:37:27 INFO - TEST-INFO | 1676: exit 0 16:37:27 INFO - TEST-OK | kraken | took 56137ms 16:37:27 INFO - SUITE-END | took 1169s 16:37:27 INFO - Completed test suite (00:19:29) 16:37:27 INFO - javascript benchmark 16:37:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3348.0, 3530.6822385985256, 3544.0785395797084, 3545.1314427965153, 3585.6772890439856, 5900.262467191606, 5908.350081491032, 5920.703964801764, 5924.674142922137, 5950.434708702672, 5882.735276912538, 5927.496162826154, 5927.992241318975, 5930.851728706784, 5964.582479226456, 5065.012322597095, 5158.9742051289695, 5261.210818377255, 5296.205569164617, 5333.57331413486, 5378.0857254266675, 5390.487903649167, 5393.892122157555, 5400.891982160354, 5402.432744561824, 5054.873628159288, 5112.872178195537, 5136.614753893473, 5139.717315547643, 5162.716050617215, 5238.397584277819, 5325.920111198335, 5333.786648534054, 5347.652402593819, 5392.595555333366, 5146.639735218499, 5251.133562962144, 5267.762950667229, 5321.068812957717, 5334.91997620036, 5684.488396044376, 5684.943150568482, 5742.368339482654, 5748.166515855178, 5763.5101016413655, 6207.813765586994, 6316.115743795872, 6326.68366581669, 6337.112804207414, 6340.651264180468, 6241.719122639447, 6272.780452684134, 6310.5267104967315, 6329.303776584572, 6333.904991425133, 6040.415290982153, 6043.8186854394435, 6045.395350693852, 6063.575549711522, 6072.696365181723, 6423.518236132309, 6440.13058237132, 6443.48452123829, 6447.903281450782, 6452.709628066748, 6159.137720719103, 6246.843828904223, 6249.593776404519, 6350.174477317919, 6385.233771947396, 6236.251649802053, 6313.179286692701, 6319.0837328587095, 6319.083732858801, 6320.241571011416, 6254.843628909222, 6322.873542529215, 6329.588576742497, 6341.143945567382, 6356.173697419398, 6165.352637973038, 6246.031865060922, 6272.2159730033745, 6284.842878928063, 6285.59143655661, 4263.339182426729, 4823.107725070873, 5013.849584512471, 5019.247112933016, 5052.115879721034, 4465.419495465569, 4476.171908196994, 4486.170058539181, 4494.303382975644, 4508.752018639007, 5761.934042202206, 5854.7072646367515, 5870.618409803349, 5908.645481271137, 5941.673207973603, 6241.469475094668, 6241.875162496815, 6284.937150628435, 6286.05709143623, 6301.747930082745, 5844.912326315109, 5848.590598658053, 5943.078822782476, 5951.940480595225, 5974.163617093611, 5474.644148130438, 5478.698671573102, 5495.120780675073, 5497.835064948058, 5503.284573005483, 6509.349065093547, 6509.804705858832, 6516.73933042673, 6520.510961677798, 6524.575902566318, 6204.410580994799, 6279.96860015697, 6285.371462853678, 6297.275813281532, 6298.874022519615, 6381.138546296191, 6464.515161362822, 6492.675366231764, 6499.1876015498065, 6513.348665133449, 6273.74905003813, 6300.905486417799, 6302.401271879165, 6308.873822523616, 6318.304986451395, 6208.50331973432, 6272.498200143887, 6284.937150628618, 6295.276043254901, 6311.842203944938, 5994.520438364833, 6231.345708700521, 6275.278342990432, 6290.748370065146, 6313.589616674902, 6238.376162383725, 6257.56197066201, 6260.906086408617, 6271.3415091414745, 6277.403646653561, 6044.697765111815, 6084.11780291864, 6095.146679464967, 6114.175715401237, 6177.84555386119, 6219.191505104308, 6283.905741413791, 6306.684665766602, 6321.683915804283, 6337.366263373626, 5254.579633629224, 6013.759449621966, 6138.202033735586, 6153.630782153085, 6164.167837341902], "unit": "score", "name": "dojo.html", "value": 5811.353975964359}, {"lowerIsBetter": false, "replicates": [449.71443133610165, 557.289455943672, 620.3796203796204, 660.6696651674163, 667.9732810687573, 32573.511397329028, 41342.0, 41736.58263417365, 41761.16477670445, 41866.790666046705, 44616.3307550387, 45126.0, 45156.87107822306, 45227.547724522745, 45238.0, 9704.757381065494, 9916.10755032047, 9925.305228633999, 9930.553125109387, 9935.552900119512, 9765.218782497419, 9911.454869982148, 9911.504424778768, 9911.752206194831, 9929.0, 9854.852177217348, 10043.497825108752, 10052.748681282954, 10052.798944021115, 10072.0, 9996.90003099967, 10035.74910627233, 10039.89960100397, 10051.346662466989, 10056.648017319396, 9769.51152442375, 9902.405855648612, 9908.256880733901, 9910.752231194207, 9911.008899110104, 43603.0, 43805.34291985591, 43832.56167438348, 43855.0, 43866.342004869955, 3268.542404063433, 3344.6320904700465, 3395.5076513905346, 3419.6409377015552, 3990.06233535119, 29111.708882911113, 29128.0, 29130.563041554393, 30343.089707308816, 30414.239644008856, 2831.844248566328, 2837.6878543360212, 2842.2894276430893, 2912.533994560881, 2939.720726530976, 500741.0, 506314.0, 507826.0, 509142.0, 509197.0, 49059.754701226266, 68867.0, 69020.6548967252, 69174.65412673005, 69187.30812691909, 48797.75601122043, 48968.265476017885, 49007.75496122568, 49008.754956225705, 49089.754551227015, 17295.654086918443, 17621.55946101332, 17637.470875873743, 17638.470845874643, 17646.91176544109, 13951.930240348733, 14049.22729249901, 14064.648383790283, 14074.366653500618, 14076.0, 16013.67972640564, 16019.199040047952, 16019.759703604455, 16036.594510823237, 16069.196540172945, 6628.801135965929, 6642.335766423415, 6698.799036028927, 6702.0, 6715.2613212546585, 942.3121121581147, 1035.063267742679, 1121.4280716834473, 1126.571902676994, 1185.6443067079842, 29232.707672923, 29587.0, 29843.701562984093, 30150.0, 30185.09444716662, 1078.6979645699216, 1186.6973921650097, 1222.358261912503, 1228.7542491501736, 1236.6970092327438, 15146.242687865562, 15240.0, 15319.693606128038, 15506.5348039559, 15592.376304947902, 668966.0, 678417.0, 685316.0, 687132.0, 689721.0, 56885.0, 67301.66349168222, 68053.31946680568, 68193.99999999901, 68258.0, 1402.8877689784792, 1529.3041666041925, 1529.7475916473657, 1556.4552406657806, 1556.564162034632, 25761.0, 30378.544321834746, 30520.445725800713, 30816.691833081382, 30873.536896946116, 53066.73466632642, 53414.198787019006, 54012.459875400746, 54128.188077179664, 54164.64588385322, 419333.0, 422586.0, 423448.0, 423796.0, 425098.0, 30372.84813575918, 34591.0, 35360.469592956644, 35848.0, 35926.461103082955, 48965.03205477591, 50377.0, 50454.495455046446, 50511.74744126256, 50676.0, 38368.2326353477, 39568.80215598903, 40060.1987960245, 40163.97950256218, 41374.37938430986, 38735.41896871493, 38814.6118538811, 38914.6108538911, 39800.80099599483, 39930.0, 39255.80372098121, 39420.60579394169, 39424.802875985435, 39950.200995979336, 40204.39693404543, 34421.65578344184, 34827.82586087054, 34839.65160348364, 35229.295414092085, 35430.46854297136, 26156.476870462866, 26211.60682589801, 26335.0, 26512.0, 26704.732952671002], "unit": "score", "name": "ext.html", "value": 20450.064028691726}, {"lowerIsBetter": false, "replicates": [337.648845200991, 380.8324337291592, 388.896942310288, 389.3167491053201, 394.81443721450944, 20236.89881550592, 20622.38132856015, 20907.477313067142, 21387.930603469802, 21398.9300534973, 12413.689657758561, 12641.051921105907, 12703.237805731662, 12724.554640587581, 12751.872481275184, 4166.66666666666, 4664.650151238654, 5925.407459254083, 6116.694165291718, 6129.570930034899, 4292.506361768405, 5837.50381217597, 6103.1455596216565, 6105.450509454148, 6108.969455152718, 6075.422834830684, 6079.939200608003, 6093.512518998492, 6106.358832322609, 6354.491640668735, 4128.710990230685, 6505.869882602345, 6516.250631177428, 6522.5760325578685, 6530.412262896339, 5557.888842223173, 5774.538036957033, 5776.855578610526, 5779.566532510079, 5787.71061446926, 13569.728605427936, 13674.521391751341, 13899.79150312746, 14261.215633140173, 14282.57152285433, 2125.2763156590486, 2137.465633591602, 2142.678598210265, 2325.8255630827757, 2350.753170917046, 10170.491475426199, 10198.592056317739, 10353.482325883675, 10489.63286284984, 10571.207159462994, 1761.3042848074938, 1783.2421220981032, 1837.8713490055702, 1841.4291569613463, 1856.1740025688573, 111226.0, 112873.0, 114790.70418591665, 114869.0, 115103.0, 11873.0, 11877.346745928884, 11890.0, 11922.390477285455, 11942.820857687142, 14477.276136193148, 14557.85442145565, 14559.92720036393, 14581.416743330361, 14585.270736463135, 9013.18881300686, 9037.77405564853, 9099.545022748836, 9113.589888455035, 9194.95402522983, 7696.191899850547, 8513.19124683154, 9252.121048500381, 9286.90713092874, 9305.53472326381, 4681.648876334289, 4687.718736875799, 4689.343491911135, 4690.742009189459, 4730.574248317668, 1738.268808832892, 1874.6531891599825, 1988.4332965104875, 1991.0641998260794, 2012.4264584593614, 717.436812102497, 757.5151902782223, 811.8619834628128, 953.909378609031, 1039.750459889621, 16773.83226167747, 20496.897515512326, 21074.262400815896, 21186.576268474546, 21449.892750536146, 975.0, 990.9653162139291, 993.8111758765812, 1039.8024375368657, 1107.64001699448, 8936.642534298686, 11302.208845380908, 11318.886811131948, 11341.489632966537, 11344.659660210207, 666079.0, 670081.0, 677465.0, 697077.0, 701715.0, 111158.44420778006, 113062.0, 116343.0, 122491.55016899612, 123813.38093309656, 1042.6611351310855, 1054.3568423261804, 1060.570468960057, 1070.1064611049705, 1071.23406764164, 17569.736453952944, 18073.548161296072, 18341.3580524681, 18536.351227706964, 18609.627807444045, 40561.59438405696, 47581.0, 49582.25626615676, 49847.75076124596, 50727.985440291726, 73012.0, 73076.0, 74688.0, 75326.87927672153, 76083.85874211781, 8032.759017229492, 8287.212714792086, 8417.0, 8418.368622353226, 8424.915750842412, 9435.622575096919, 13320.000999925238, 13321.800172997218, 13400.195988240737, 13863.653408664864, 7725.459217854696, 11530.481128349076, 11819.349935753617, 11908.523659053888, 11987.580434684744, 11549.595764148215, 11593.6521904343, 11600.825987610024, 11728.41357932117, 11819.527218911147, 10052.39685618836, 11044.558217671203, 11633.836616338298, 11860.288382697066, 11949.342786146497, 8206.179382061746, 8309.04445988719, 8357.791055223668, 8570.74287771368, 8577.313814894918, 11405.087592992375, 11580.652580422264, 11694.181407301407, 11925.0, 12000.519979201083], "unit": "score", "name": "jquery.html", "value": 9341.587205965725}, {"lowerIsBetter": false, "replicates": [1502.8196616406033, 1607.1642745772197, 1663.62568422105, 2013.7382140321756, 2106.8314534837214, 8434.746957591275, 8966.417182883108, 9173.403728757627, 9174.541272936343, 9191.908080919196, 9037.367384283103, 9308.813823723522, 9311.95344023279, 9314.813703725922, 9322.067793220675, 2036.1346427768212, 2283.235116236063, 2385.475195457005, 2537.5559277126476, 2567.679040119985, 2446.8409553378974, 2450.754924507553, 2453.264020793764, 2455.3370589940705, 2457.066314800373, 2161.7622061573215, 2448.698910692753, 2592.520383729007, 2593.6757905261843, 2593.844369337846, 2532.6813691248417, 2560.513502434541, 2603.5183491054217, 2614.2157352794084, 2614.673165854268, 2533.2147034419204, 2571.6785401824773, 2583.2379448062866, 2585.250277419546, 2586.5473542130053, 9272.0, 9335.626574936994, 9337.533123343806, 9338.439693618404, 9346.532673366304, 5667.858303542444, 5781.884362312772, 5810.535157187415, 5848.561357898132, 5874.676892770896, 3662.285854258421, 3748.306563285801, 3799.2781371539595, 3810.123671555558, 3815.1606646537716, 1058.5395353021383, 1066.5040756048475, 1074.135321066541, 1089.8528698625664, 1111.2221444988459, 12810.911072558843, 12822.743545129139, 12824.038197135158, 12832.615021549369, 12848.614541563767, 5087.771050302671, 5125.666831655931, 5234.502722241381, 5235.188545775411, 5252.65857719247, 10710.303830251165, 10721.0, 10739.463026848782, 10755.354678719146, 10758.139348852073, 5805.506531944748, 5844.561657875676, 5846.883062338729, 5847.619904706181, 5853.707314634251, 4688.601468875184, 5063.721495317793, 5182.637215394886, 5240.502152295526, 5250.894982100413, 4061.8375264989068, 4069.8168582413864, 4091.1408604192857, 4095.2833254180996, 4145.854895078658, 1178.911581631381, 1238.9566365177175, 1370.0683535195963, 1376.9586912392645, 1380.323641415719, 1251.1867286264, 1273.6433798536425, 1396.1692792788274, 1440.6038339456525, 1444.3572610188576, 7266.854662906818, 8560.0583935767, 8618.138186181332, 8635.78410539729, 8650.178233067849, 1145.5131569083105, 1258.3016425883538, 1272.166730791333, 1272.2557303977278, 1275.8787915148046, 6435.195600549931, 6537.280899101095, 6620.337966203438, 6621.768238111643, 6624.8012559623285, 10965.232433729563, 11228.101751859831, 11281.32312061279, 11312.264702794457, 11383.260088094248, 10615.0, 10908.945455272673, 10964.342139471657, 11212.215144939775, 11231.315302704495, 8660.78348041304, 8807.559622018873, 8830.161134692322, 8893.688720894737, 8902.109789021046, 8231.176882311722, 8558.743237702878, 8576.356773241907, 8578.442401244149, 8589.613467393858, 9676.371035882645, 9888.406695598287, 9983.950080249553, 10136.290459667753, 10187.643432479828, 10202.132818710492, 10269.229807764297, 10638.0, 10664.466776661291, 10876.728081798019, 7223.638818058971, 7440.813979650552, 7699.807504812425, 7949.8410031800195, 8066.274035336848, 8704.0, 8734.432261902955, 8766.956165219133, 8773.692920747742, 8790.857188565446, 7637.656305466378, 7695.730649427467, 7760.611969401621, 7874.960625197066, 7883.172266911892, 7507.474476786572, 7537.057867766529, 7550.7734767957045, 7651.693932242648, 7736.651850666621, 8036.437449378487, 8197.385196110436, 8212.30195433371, 8220.547869867214, 8221.79445513843, 7302.598357090411, 7446.7021319146625, 7458.73894413693, 7478.738244161428, 7500.249975002456, 7509.098908131059, 7510.211427800003, 7560.243975602396, 7571.507851989603, 7593.506422082547], "unit": "score", "name": "mootools.html", "value": 5196.416080036369}, {"lowerIsBetter": false, "replicates": [339.60436091952874, 347.53603938741793, 351.89091381671676, 352.2356486424459, 358.9605143434222, 6562.835929101775, 6564.0, 6624.5694029888145, 6667.399934005938, 6688.832779180523, 5405.945840561092, 6573.539852210347, 6578.2106147262275, 6589.934100658992, 6591.077249185118, 4048.2308361411383, 4764.499727528611, 4813.59084477818, 4874.756262186894, 4976.178930476467, 4968.3292755477905, 4986.626003049786, 4990.151674215392, 4996.525330093636, 5007.198848184291, 4056.3509838425857, 4967.155583550787, 4967.379077615298, 4976.576990955773, 4985.950140498603, 4715.339852420664, 4793.880152996186, 4871.951280487186, 4911.336969509106, 4921.212605983025, 4236.830526778926, 4241.130568233505, 4242.4272723182285, 4250.978745106286, 4257.19113368459, 6390.9360906391275, 6419.5506314558, 6430.646314452703, 6438.8390290243115, 6441.194850643669, 5822.592418530662, 5903.291605007384, 5918.911216331759, 5921.141434491975, 5926.97036514819, 5969.820905372802, 6837.418819400357, 7108.964455177743, 7121.465890058266, 7141.571505709674, 4638.8608341749805, 4797.712137271775, 4828.73441960692, 4829.034193161347, 4831.0, 6428.550001499897, 7438.516496427715, 7442.032535770423, 7457.552546847207, 7460.850782984364, 4876.634252431082, 4883.487233840396, 4885.0, 4885.926711099336, 4886.53577910098, 4954.578860796801, 4956.925646115311, 4960.0, 4970.627202959792, 4979.979104283613, 5688.0, 5848.0, 5875.912956103135, 5887.558433117533, 5889.469947704727, 7065.505414620927, 7113.82215444618, 7113.928860711327, 7123.964380178066, 7125.82185445368, 1390.32569203936, 1451.7822326650876, 1740.4256595323513, 1742.9041402722971, 1745.2233755978468, 1060.4273692206277, 1103.6082190822142, 1121.786860496503, 1134.4214450630072, 1154.7459558897028, 5469.453054694499, 6478.740850365933, 6647.1026411434805, 6656.36764507371, 6674.0, 7438.851222975511, 7438.962805186047, 7444.516106453171, 7450.143233528105, 7458.813529661693, 6645.302243264484, 6649.3018233085795, 6650.9667451662435, 6651.86696266072, 6658.700358483879, 3760.8119594020736, 3882.708796840192, 3912.374020156761, 3916.334223182009, 3916.8433262669746, 7677.577733224614, 7678.577678227751, 7680.923190768132, 7692.230776922263, 7698.92301076982, 7546.094468663796, 7600.315971562475, 7606.201348858401, 7611.048618922635, 7616.971708819238, 7660.846783064308, 7670.731524396842, 7674.961625191839, 7676.692932282758, 7678.808029799188, 7104.0, 7328.78013659591, 7390.852182956418, 7401.296876796696, 7401.851962960818, 7214.783556493314, 7225.132984041738, 7256.891146632699, 7269.7455589054125, 7301.306375894282, 7678.0, 7680.155182929761, 7684.462087654034, 7689.461737678533, 7694.461387702807, 3947.9407808882315, 4699.060187962353, 4757.858114052533, 4758.333833263415, 4763.237881938873, 6063.181470501426, 7089.397401220954, 7376.7786966391095, 7391.039164908528, 7395.7041718330665, 5743.3395159557185, 7157.57054576727, 7166.283371662792, 7167.784966451015, 7173.175084865307, 7027.01621772942, 7112.0754301940415, 7130.500864939404, 7135.322144396274, 7142.535735177197, 5850.268716410449, 6980.0, 6984.3364880336285, 6996.160460744743, 7003.859922801414, 6889.207741109836, 7106.040684507525, 7141.143062832493, 7145.17830449505, 7165.0, 6802.8639427212165, 6846.965765171142, 6965.199002114821, 6989.825254368681, 6999.230084690578], "unit": "score", "name": "prototype.html", "value": 5212.941374964484}, {"lowerIsBetter": false, "replicates": [672.153087110241, 694.5971336624758, 733.2154594583794, 753.2806170107548, 770.1066762555437, 12054.939725301372, 15307.081575105474, 15489.457868974589, 15511.689766204669, 15536.611584710374, 12590.118691691585, 14009.299535023234, 14529.636759081002, 14531.709365812678, 14566.708665826676, 975.9219262459022, 1015.5024038221293, 1028.115820394464, 1033.0650761061252, 1039.215392378753, 824.826786374862, 830.6511265268601, 1021.9386836789779, 1037.066640023977, 1049.574922156524, 1076.214363514635, 1078.8867168947265, 1082.3289560472517, 1083.0685610375072, 1084.7233955341376, 1068.8877667844843, 1070.8019016481937, 1071.4535586850684, 1076.1122074288744, 1078.7896360209763, 645.5771469687362, 654.8362909272682, 798.2855344466727, 812.5530957973091, 819.4550623835142, 15469.922650386789, 15482.22588870552, 15499.5350139496, 15506.379744810194, 15525.378984840592, 11114.166437517139, 11249.775004499947, 11386.487608057658, 11498.965093141658, 11540.884591154065, 9176.08239176077, 10087.445190514518, 10208.234382421348, 10292.228082893813, 10924.836127458095, 3477.196752626543, 3518.313928783888, 3526.3828829954914, 3602.7838329700303, 3782.0, 82996.0, 85931.0, 86160.7075893862, 86514.0, 92716.0, 9879.703608891745, 10027.298089133836, 10046.397216166908, 10315.432651204255, 10924.617638382619, 23139.190128345763, 23340.183093591982, 23431.179908703114, 23833.04667813303, 23881.7611823883, 7794.10367807698, 7837.882431763528, 8015.238552337519, 8032.879506807402, 8096.149904259968, 4199.286121359315, 4214.17823524416, 4253.787310634456, 4266.6160045595425, 4347.5217726050105, 3659.70722342212, 3748.231612519427, 3750.9437358439645, 3809.9809500952874, 3851.557070936878, 703.1702590942634, 719.3633634233636, 725.408791834653, 737.2406421385981, 739.4306384084225, 492.2198315669632, 511.68275669085403, 570.5350139636183, 572.6936089192345, 588.6674029173589, 8119.350451963829, 8119.83760324802, 8129.715459958873, 8174.223448772357, 8310.584470776557, 534.4468475128224, 592.6769910398843, 600.2047287344286, 604.1330690459205, 607.3562024254304, 3757.94777462311, 3854.8843534694006, 3872.7482713623526, 3896.7272290939927, 3902.0635047588944, 90689.63965540522, 95007.0, 95860.0, 95978.0, 96126.0, 78510.6074469624, 81882.3623527526, 81975.7703634446, 82771.17228827755, 82894.58552707198, 71466.92799607906, 71549.6422517884, 71899.0, 72517.6374118126, 72537.6373118131, 7638.732644357421, 7776.572288524186, 7834.725784597512, 7905.051393832547, 8060.566240592606, 39320.80339598284, 49348.75325623349, 49622.75188624034, 50178.498215018844, 50518.49481505285, 64358.71282574416, 64415.0, 65129.02306465502, 65972.00838357784, 66206.0, 10064.144547713233, 10190.184785217312, 10194.490275486047, 10374.844377334195, 10912.781744365227, 10511.316764410289, 10609.363438193734, 10735.194860385345, 10921.945390272998, 11483.8277425837, 10123.544440500342, 10218.846717299395, 10322.690319290434, 10428.374297542172, 11046.447677615926, 10155.289129760846, 10256.12822910061, 10389.37663740178, 10491.790164196826, 10499.94750026245, 9954.601815927572, 9980.900190997998, 10038.949805250926, 10165.745856353651, 10178.491075446345, 8545.786355341166, 8653.870191947251, 8732.956335218283, 8793.164649358556, 9008.369414141209, 8809.955950220208, 8898.55507224649, 8978.461292322481, 9141.63433462654, 9298.581563829508], "unit": "score", "name": "yui.html", "value": 6954.173741251854}], "name": "dromaeo_css", "value": 7704.475716250145}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 110.0, 111.0, 112.0, 112.0, 119.0, 113.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [151.0, 119.0, 141.0, 155.0, 117.0, 136.0, 116.0, 149.0, 144.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 134.5}, {"lowerIsBetter": true, "replicates": [178.0, 182.0, 184.0, 185.0, 182.0, 183.0, 182.0, 181.0, 184.0, 185.0], "unit": "score", "name": "audio-dft", "value": 182.6}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 74.0, 115.0, 58.0, 81.0, 79.0, 58.0, 118.0, 55.0], "unit": "score", "name": "audio-fft", "value": 78.6}, {"lowerIsBetter": true, "replicates": [85.0, 91.0, 132.0, 77.0, 78.0, 85.0, 121.0, 76.0, 79.0, 101.0], "unit": "score", "name": "audio-oscillator", "value": 92.5}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 86.0, 85.0, 87.0, 84.0, 87.0, 84.0, 86.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.2}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 92.0, 92.0, 91.0, 92.0, 93.0, 92.0, 92.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 92.1}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 84.0, 85.0, 87.0, 83.0, 87.0, 83.0, 84.0, 101.0], "unit": "score", "name": "imaging-desaturate", "value": 86.2}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 58.0, 57.0, 59.0, 59.0, 57.0, 68.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 76.0, 72.0, 68.0, 67.0, 65.0, 65.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [81.0, 79.0, 79.0, 80.0, 80.0, 79.0, 77.0, 97.0, 105.0, 116.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.3}, {"lowerIsBetter": true, "replicates": [133.0, 121.0, 127.0, 111.0, 118.0, 135.0, 122.0, 126.0, 122.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.5}, {"lowerIsBetter": true, "replicates": [133.0, 120.0, 131.0, 126.0, 136.0, 132.0, 133.0, 160.0, 162.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.4}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 67.0, 86.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1404.4}]} 16:37:27 INFO - Return code: 0 16:37:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:37:27 INFO - # TBPL SUCCESS # 16:37:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:37:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:37:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:37:27 INFO - 2016-03-14 16:37:27.686 screenresolution[1680:9646] starting screenresolution argv=screenresolution get 16:37:27 INFO - 2016-03-14 16:37:27.689 screenresolution[1680:9646] Display 0: 1600x1200x32@60 16:37:27 INFO - 2016-03-14 16:37:27.695 screenresolution[1681:9649] starting screenresolution argv=screenresolution list 16:37:27 INFO - Available Modes on Display 0 16:37:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:37:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:37:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:37:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:37:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:37:27 INFO - Intel Iris: 16:37:27 INFO - Chipset Model: Intel Iris 16:37:27 INFO - Type: GPU 16:37:27 INFO - Bus: Built-In 16:37:27 INFO - VRAM (Dynamic, Max): 1536 MB 16:37:27 INFO - Vendor: Intel (0x8086) 16:37:27 INFO - Device ID: 0x0a2e 16:37:27 INFO - Revision ID: 0x0009 16:37:27 INFO - Displays: 16:37:27 INFO - Display: 16:37:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:37:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:37:27 INFO - Display Serial Number: 1600x1200 60 16:37:27 INFO - Main Display: Yes 16:37:27 INFO - Mirror: Off 16:37:27 INFO - Online: Yes 16:37:27 INFO - Rotation: Supported 16:37:27 INFO - Return code: 0 16:37:27 INFO - Running post-action listener: _resource_record_post_action 16:37:27 INFO - Running post-run listener: _resource_record_post_run 16:37:28 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 42489344; Write bytes: 662314496; Read time: 540; Write time: 2139 16:37:28 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 362105344; Write bytes: 363202048; Read time: 28212; Write time: 699 16:37:28 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 40670720; Write bytes: 298264576; Read time: 521; Write time: 1439 16:37:28 INFO - Running post-run listener: _upload_blobber_files 16:37:28 INFO - Blob upload gear active. 16:37:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:37:28 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 16:37:28 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'] 16:37:28 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 16:37:29 INFO - (blobuploader) - INFO - Open directory for files ... 16:37:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:37:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:37:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:37:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:37:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:37:30 INFO - (blobuploader) - INFO - Done attempting. 16:37:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:37:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:37:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:37:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:37:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:37:31 INFO - (blobuploader) - INFO - Done attempting. 16:37:31 INFO - (blobuploader) - INFO - Iteration through files over. 16:37:31 INFO - Return code: 0 16:37:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:37:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:37:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d933ca9675cd8c415c01bd6f5a22414e990d2c3528a83970c7d6bfabde7d6f8b13d3fe0af50d729b125d68d672a1f349fa71a989ceecead50d98fac0f5c5063", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c276275851be8964567b4e07a93bd6cf8e94edc2cf23bf4bfa8f504f3ea75fddb122de328184dba9545490c2bd74861b9bf6847d086dc2a4bea79195cb9f54c2"} 16:37:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:37:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:37:31 INFO - Contents: 16:37:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d933ca9675cd8c415c01bd6f5a22414e990d2c3528a83970c7d6bfabde7d6f8b13d3fe0af50d729b125d68d672a1f349fa71a989ceecead50d98fac0f5c5063", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c276275851be8964567b4e07a93bd6cf8e94edc2cf23bf4bfa8f504f3ea75fddb122de328184dba9545490c2bd74861b9bf6847d086dc2a4bea79195cb9f54c2"} 16:37:31 INFO - Running post-run listener: copy_logs_to_upload_dir 16:37:31 INFO - Copying logs to upload dir... 16:37:31 INFO - mkdir: /builds/slave/test/build/upload/logs 16:37:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.397458 ========= master_lag: 13.85 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-03-14 16:37:45.296692) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-03-14 16:37:45.299865) ========= 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.kEYhwVLtHj/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.eeA7HXZwUs/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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/9d933ca9675cd8c415c01bd6f5a22414e990d2c3528a83970c7d6bfabde7d6f8b13d3fe0af50d729b125d68d672a1f349fa71a989ceecead50d98fac0f5c5063", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c276275851be8964567b4e07a93bd6cf8e94edc2cf23bf4bfa8f504f3ea75fddb122de328184dba9545490c2bd74861b9bf6847d086dc2a4bea79195cb9f54c2"} build_url:https://queue.taskcluster.net/v1/task/OfOviVFKQx6bobI5FpZ6zQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011132 build_url: 'https://queue.taskcluster.net/v1/task/OfOviVFKQx6bobI5FpZ6zQ/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/9d933ca9675cd8c415c01bd6f5a22414e990d2c3528a83970c7d6bfabde7d6f8b13d3fe0af50d729b125d68d672a1f349fa71a989ceecead50d98fac0f5c5063", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c276275851be8964567b4e07a93bd6cf8e94edc2cf23bf4bfa8f504f3ea75fddb122de328184dba9545490c2bd74861b9bf6847d086dc2a4bea79195cb9f54c2"}' ========= master_lag: 2.82 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-03-14 16:37:48.128001) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:37:48.128310) ========= 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.kEYhwVLtHj/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.eeA7HXZwUs/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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.005617 ========= master_lag: 0.21 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:37:48.343994) ========= ========= Started reboot skipped (results: 3, elapsed: 13 secs) (at 2016-03-14 16:37:48.344320) ========= ========= Finished reboot skipped (results: 3, elapsed: 13 secs) (at 2016-03-14 16:38:01.638868) ========= ========= Total master_lag: 17.05 =========