builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0150 starttime: 1459344001.57 results: success (0) buildid: 20160330041034 builduid: 1a801db830e948f49ab4e3dabbc9eb2c revision: 435e4e199131c10583596524bf79cf1120e6a795 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-30 06:20:01.572839) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-30 06:20:01.573317) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-30 06:20:01.573621) ========= 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.0Fw3JhsLok/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.nUMn6qpQ5v/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.005521 basedir: '/builds/slave/test' ========= master_lag: 0.49 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-30 06:20:02.065332) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-30 06:20:02.065655) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-30 06:20:02.560657) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 06:20:02.561109) ========= 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.0Fw3JhsLok/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.nUMn6qpQ5v/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.005335 ========= master_lag: 0.24 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 06:20:02.807280) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-30 06:20:02.807603) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-30 06:20:02.807994) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 06:20:02.808313) ========= 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.0Fw3JhsLok/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.nUMn6qpQ5v/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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-30 06:20:02-- 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% 25.1M=0s 2016-03-30 06:20:02 (25.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115420 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 06:20:02.957903) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 06:20:02.958282) ========= 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.0Fw3JhsLok/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.nUMn6qpQ5v/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.025441 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 06:20:03.041017) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 06:20:03.041422) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 435e4e199131c10583596524bf79cf1120e6a795 --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 435e4e199131c10583596524bf79cf1120e6a795 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0Fw3JhsLok/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.nUMn6qpQ5v/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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-30 06:20:03,137 truncating revision to first 12 chars 2016-03-30 06:20:03,137 Setting DEBUG logging. 2016-03-30 06:20:03,137 attempt 1/10 2016-03-30 06:20:03,137 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/435e4e199131?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-30 06:20:03,841 unpacking tar archive at: mozilla-aurora-435e4e199131/testing/mozharness/ program finished with exit code 0 elapsedTime=0.949053 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 06:20:04.015879) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-30 06:20:04.019399) ========= echo 435e4e199131c10583596524bf79cf1120e6a795 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'435e4e199131c10583596524bf79cf1120e6a795'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0Fw3JhsLok/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.nUMn6qpQ5v/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 435e4e199131c10583596524bf79cf1120e6a795 program finished with exit code 0 elapsedTime=0.005282 script_repo_revision: '435e4e199131c10583596524bf79cf1120e6a795' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-30 06:20:04.070970) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-30 06:20:04.074421) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-30 06:20:04.091893) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-03-30 06:20:04.092299) ========= /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.0Fw3JhsLok/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.nUMn6qpQ5v/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 06:20:04 INFO - MultiFileLogger online at 20160330 06:20:04 in /builds/slave/test 06:20:04 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 06:20:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:20:04 INFO - {'append_to_log': False, 06:20:04 INFO - 'base_work_dir': '/builds/slave/test', 06:20:04 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:20:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:20:04 INFO - 'branch': 'Mozilla-Aurora', 06:20:04 INFO - 'buildbot_json_path': 'buildprops.json', 06:20:04 INFO - 'config_files': ('talos/mac_config.py',), 06:20:04 INFO - 'default_actions': ('clobber', 06:20:04 INFO - 'read-buildbot-config', 06:20:04 INFO - 'download-and-extract', 06:20:04 INFO - 'populate-webroot', 06:20:04 INFO - 'create-virtualenv', 06:20:04 INFO - 'install', 06:20:04 INFO - 'run-tests'), 06:20:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:20:04 INFO - 'download_minidump_stackwalk': True, 06:20:04 INFO - 'download_symbols': 'ondemand', 06:20:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:20:04 INFO - 'tooltool.py': '/tools/tooltool.py', 06:20:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:20:04 INFO - '/tools/misc-python/virtualenv.py')}, 06:20:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:20:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:20:04 INFO - 'installer_path': 'installer.exe', 06:20:04 INFO - 'log_level': 'info', 06:20:04 INFO - 'log_name': 'talos', 06:20:04 INFO - 'log_to_console': True, 06:20:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:20:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:20:04 INFO - 'opt_config_files': (), 06:20:04 INFO - 'pip_index': False, 06:20:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:20:04 INFO - 'cmd': ('bash', 06:20:04 INFO - '-c', 06:20:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:20:04 INFO - 'enabled': True, 06:20:04 INFO - 'halt_on_failure': False, 06:20:04 INFO - 'name': 'check_screen_resolution'},), 06:20:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:20:04 INFO - 'cmd': ('bash', 06:20:04 INFO - '-c', 06:20:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:20:04 INFO - 'enabled': True, 06:20:04 INFO - 'halt_on_failure': False, 06:20:04 INFO - 'name': 'check_screen_resolution'},), 06:20:04 INFO - 'run_cmd_checks_enabled': True, 06:20:04 INFO - 'sps_profile': False, 06:20:04 INFO - 'sps_profile_interval': 0, 06:20:04 INFO - 'suite': 'dromaeojs', 06:20:04 INFO - 'system_bits': '32', 06:20:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:20:04 INFO - 'title': 't-yosemite-r7-0150', 06:20:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:20:04 INFO - 'use_talos_json': True, 06:20:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:20:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:20:04 INFO - 'work_dir': 'build'} 06:20:04 INFO - ##### 06:20:04 INFO - ##### Running clobber step. 06:20:04 INFO - ##### 06:20:04 INFO - Running pre-action listener: _resource_record_pre_action 06:20:04 INFO - Running main action method: clobber 06:20:04 INFO - rmtree: /builds/slave/test/build 06:20:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:20:05 INFO - Running post-action listener: _resource_record_post_action 06:20:05 INFO - ##### 06:20:05 INFO - ##### Running read-buildbot-config step. 06:20:05 INFO - ##### 06:20:05 INFO - Running pre-action listener: _resource_record_pre_action 06:20:05 INFO - Running main action method: read_buildbot_config 06:20:05 INFO - Using buildbot properties: 06:20:05 INFO - { 06:20:05 INFO - "project": "", 06:20:05 INFO - "product": "firefox", 06:20:05 INFO - "script_repo_revision": "production", 06:20:05 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 06:20:05 INFO - "repository": "", 06:20:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 06:20:05 INFO - "buildid": "20160330041034", 06:20:05 INFO - "pgo_build": "False", 06:20:05 INFO - "basedir": "/builds/slave/test", 06:20:05 INFO - "buildnumber": 148, 06:20:05 INFO - "slavename": "t-yosemite-r7-0150", 06:20:05 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 06:20:05 INFO - "platform": "yosemite_r7", 06:20:05 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 06:20:05 INFO - "branch": "mozilla-aurora", 06:20:05 INFO - "repo_path": "releases/mozilla-aurora", 06:20:05 INFO - "revision": "435e4e199131c10583596524bf79cf1120e6a795", 06:20:05 INFO - "stage_platform": "macosx64", 06:20:05 INFO - "builduid": "1a801db830e948f49ab4e3dabbc9eb2c", 06:20:05 INFO - "slavebuilddir": "test" 06:20:05 INFO - } 06:20:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/THTHp_rfStu6IcFyl4nKcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 06:20:05 INFO - Running post-action listener: _resource_record_post_action 06:20:05 INFO - ##### 06:20:05 INFO - ##### Running download-and-extract step. 06:20:05 INFO - ##### 06:20:05 INFO - Running pre-action listener: _resource_record_pre_action 06:20:05 INFO - Running main action method: download_and_extract 06:20:05 INFO - mkdir: /builds/slave/test/build/tests 06:20:05 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')]} 06:20:05 INFO - https://queue.taskcluster.net/v1/task/THTHp_rfStu6IcFyl4nKcg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:20:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THTHp_rfStu6IcFyl4nKcg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 06:20:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THTHp_rfStu6IcFyl4nKcg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 06:20:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THTHp_rfStu6IcFyl4nKcg/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 06:20:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THTHp_rfStu6IcFyl4nKcg/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 06:20:08 INFO - Downloaded 1277 bytes. 06:20:08 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 06:20:08 INFO - Using the following test package requirements: 06:20:08 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 06:20:08 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 06:20:08 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 06:20:08 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 06:20:08 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 06:20:08 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 06:20:08 INFO - u'jsshell-mac.zip'], 06:20:08 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 06:20:08 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 06:20:08 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 06:20:08 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 06:20:08 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 06:20:08 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 06:20:08 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 06:20:08 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 06:20:08 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 06:20:08 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 06:20:08 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 06:20:08 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 06:20:08 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 06:20:08 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')]} 06:20:08 INFO - https://queue.taskcluster.net/v1/task/THTHp_rfStu6IcFyl4nKcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:20:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THTHp_rfStu6IcFyl4nKcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 06:20:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THTHp_rfStu6IcFyl4nKcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 06:20:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THTHp_rfStu6IcFyl4nKcg/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 06:20:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THTHp_rfStu6IcFyl4nKcg/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 06:20:09 INFO - Downloaded 17903203 bytes. 06:20:09 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'] 06:20:09 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 06:20:12 INFO - Return code: 0 06:20:12 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 06:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:20:12 INFO - https://queue.taskcluster.net/v1/task/THTHp_rfStu6IcFyl4nKcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:20:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THTHp_rfStu6IcFyl4nKcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 06:20:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THTHp_rfStu6IcFyl4nKcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 06:20:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THTHp_rfStu6IcFyl4nKcg/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 06:20:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THTHp_rfStu6IcFyl4nKcg/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 06:20:13 INFO - Downloaded 17903203 bytes. 06:20:13 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'] 06:20:13 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 06:20:17 INFO - Return code: 0 06:20:17 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')]} 06:20:17 INFO - https://queue.taskcluster.net/v1/task/THTHp_rfStu6IcFyl4nKcg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:20:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THTHp_rfStu6IcFyl4nKcg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 06:20:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THTHp_rfStu6IcFyl4nKcg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 06:20:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THTHp_rfStu6IcFyl4nKcg/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 06:20:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THTHp_rfStu6IcFyl4nKcg/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 06:20:18 INFO - Downloaded 10845161 bytes. 06:20:18 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'] 06:20:18 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 06:20:18 INFO - Return code: 0 06:20:18 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')]} 06:20:18 INFO - https://queue.taskcluster.net/v1/task/THTHp_rfStu6IcFyl4nKcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 06:20:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THTHp_rfStu6IcFyl4nKcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 06:20:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THTHp_rfStu6IcFyl4nKcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 06:20:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THTHp_rfStu6IcFyl4nKcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 06:20:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THTHp_rfStu6IcFyl4nKcg/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 06:20:21 INFO - Downloaded 115015783 bytes. 06:20:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/THTHp_rfStu6IcFyl4nKcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 06:20:21 INFO - mkdir: /builds/slave/test/properties 06:20:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:20:21 INFO - Writing to file /builds/slave/test/properties/build_url 06:20:21 INFO - Contents: 06:20:21 INFO - build_url:https://queue.taskcluster.net/v1/task/THTHp_rfStu6IcFyl4nKcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 06:20:22 INFO - Running post-action listener: _resource_record_post_action 06:20:22 INFO - Running post-action listener: set_extra_try_arguments 06:20:22 INFO - ##### 06:20:22 INFO - ##### Running populate-webroot step. 06:20:22 INFO - ##### 06:20:22 INFO - Running pre-action listener: _resource_record_pre_action 06:20:22 INFO - Running main action method: populate_webroot 06:20:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:20:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:20:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:20:22 INFO - '--tppagecycles', 06:20:22 INFO - '7'], 06:20:22 INFO - 'tests': ['tsvgm']}}, 06:20:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:20:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:20:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:20:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:20:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:20:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:20:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:20:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:22 INFO - 'talos_options': ['--e10s'], 06:20:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:20:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:22 INFO - 'tests': ['damp', 'tps']}, 06:20:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:22 INFO - 'talos_options': ['--e10s'], 06:20:22 INFO - 'tests': ['damp', 'tps']}, 06:20:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:20:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:20:22 INFO - 'other': {'tests': ['a11yr', 06:20:22 INFO - 'ts_paint', 06:20:22 INFO - 'tpaint', 06:20:22 INFO - 'sessionrestore', 06:20:22 INFO - 'sessionrestore_no_auto_restore', 06:20:22 INFO - 'tabpaint']}, 06:20:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:20:22 INFO - 'tests': ['a11yr', 06:20:22 INFO - 'ts_paint', 06:20:22 INFO - 'tpaint', 06:20:22 INFO - 'sessionrestore', 06:20:22 INFO - 'sessionrestore_no_auto_restore', 06:20:22 INFO - 'tabpaint']}, 06:20:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:20:22 INFO - 'tests': ['a11yr', 06:20:22 INFO - 'ts_paint', 06:20:22 INFO - 'tpaint', 06:20:22 INFO - 'sessionrestore', 06:20:22 INFO - 'sessionrestore_no_auto_restore', 06:20:22 INFO - 'tabpaint']}, 06:20:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:20:22 INFO - 'tests': ['a11yr', 06:20:22 INFO - 'ts_paint', 06:20:22 INFO - 'tpaint', 06:20:22 INFO - 'sessionrestore', 06:20:22 INFO - 'sessionrestore_no_auto_restore', 06:20:22 INFO - 'tabpaint']}, 06:20:22 INFO - 'other_l64': {'tests': ['a11yr', 06:20:22 INFO - 'ts_paint', 06:20:22 INFO - 'tpaint', 06:20:22 INFO - 'sessionrestore', 06:20:22 INFO - 'sessionrestore_no_auto_restore', 06:20:22 INFO - 'tabpaint']}, 06:20:22 INFO - 'other_nol64': {'tests': ['a11yr', 06:20:22 INFO - 'ts_paint', 06:20:22 INFO - 'tpaint', 06:20:22 INFO - 'sessionrestore', 06:20:22 INFO - 'sessionrestore_no_auto_restore', 06:20:22 INFO - 'tabpaint']}, 06:20:22 INFO - 'svgr': {'tests': ['tsvgx', 06:20:22 INFO - 'tsvgr_opacity', 06:20:22 INFO - 'tart', 06:20:22 INFO - 'tscrollx', 06:20:22 INFO - 'cart']}, 06:20:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:20:22 INFO - 'tests': ['tsvgx', 06:20:22 INFO - 'tsvgr_opacity', 06:20:22 INFO - 'tart', 06:20:22 INFO - 'tscrollx', 06:20:22 INFO - 'cart']}, 06:20:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:22 INFO - 'tests': ['tp5o']}, 06:20:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:22 INFO - 'talos_options': ['--e10s'], 06:20:22 INFO - 'tests': ['tp5o']}, 06:20:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:22 INFO - 'talos_options': ['--xperf_path', 06:20:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:20:22 INFO - 'tests': ['tp5n']}, 06:20:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:22 INFO - 'talos_options': ['--e10s', 06:20:22 INFO - '--xperf_path', 06:20:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:20:22 INFO - 'tests': ['tp5n']}}, 06:20:22 INFO - 'talos.zip': {'path': '', 06:20:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:20:22 INFO - Running post-action listener: _resource_record_post_action 06:20:22 INFO - ##### 06:20:22 INFO - ##### Running create-virtualenv step. 06:20:22 INFO - ##### 06:20:22 INFO - Running pre-action listener: _resource_record_pre_action 06:20:22 INFO - Running main action method: create_virtualenv 06:20:22 INFO - Creating virtualenv /builds/slave/test/build/venv 06:20:22 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 06:20:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:20:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:20:22 INFO - Using real prefix '/tools/python27' 06:20:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:20:23 INFO - Installing distribute.............................................................................................................................................................................................done. 06:20:26 INFO - Installing pip.................done. 06:20:26 INFO - Return code: 0 06:20:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:20:26 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')]} 06:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:26 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')]} 06:20:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:26 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 0x10ca92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f817855b660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c936d30>, '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 0x10c79adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c92db20>, '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.0Fw3JhsLok/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.nUMn6qpQ5v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 06:20:26 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 06:20:26 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 06:20:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Fw3JhsLok/Render', 06:20:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:20:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:20:26 INFO - 'HOME': '/Users/cltbld', 06:20:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:20:26 INFO - 'LOGNAME': 'cltbld', 06:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:26 INFO - 'MOZ_NO_REMOTE': '1', 06:20:26 INFO - 'NO_EM_RESTART': '1', 06:20:26 INFO - 'PAGER': '/bin/cat', 06:20:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:26 INFO - 'PWD': '/builds/slave/test', 06:20:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:20:26 INFO - 'SHELL': '/bin/bash', 06:20:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nUMn6qpQ5v/Listeners', 06:20:26 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 06:20:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:20:26 INFO - 'USER': 'cltbld', 06:20:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:20:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:26 INFO - 'XPC_FLAGS': '0x0', 06:20:26 INFO - 'XPC_SERVICE_NAME': '0', 06:20:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:26 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 06:20:26 INFO - Cleaning up... 06:20:26 INFO - Return code: 0 06:20:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:20:26 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')]} 06:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:26 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')]} 06:20:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:26 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 0x10ca92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f817855b660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c936d30>, '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 0x10c79adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c92db20>, '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.0Fw3JhsLok/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.nUMn6qpQ5v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 06:20:26 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 06:20:26 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 06:20:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Fw3JhsLok/Render', 06:20:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:20:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:20:26 INFO - 'HOME': '/Users/cltbld', 06:20:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:20:26 INFO - 'LOGNAME': 'cltbld', 06:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:26 INFO - 'MOZ_NO_REMOTE': '1', 06:20:26 INFO - 'NO_EM_RESTART': '1', 06:20:26 INFO - 'PAGER': '/bin/cat', 06:20:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:26 INFO - 'PWD': '/builds/slave/test', 06:20:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:20:26 INFO - 'SHELL': '/bin/bash', 06:20:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nUMn6qpQ5v/Listeners', 06:20:26 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 06:20:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:20:26 INFO - 'USER': 'cltbld', 06:20:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:20:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:26 INFO - 'XPC_FLAGS': '0x0', 06:20:26 INFO - 'XPC_SERVICE_NAME': '0', 06:20:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:26 INFO - Downloading/unpacking psutil>=0.7.1 06:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:20:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:20:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:20:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:20:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:20:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:20:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:20:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:20:30 INFO - Installing collected packages: psutil 06:20:30 INFO - Running setup.py install for psutil 06:20:30 INFO - building 'psutil._psutil_osx' extension 06:20:30 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 06:20:31 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 06:20:31 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 06:20:31 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 06:20:31 INFO - building 'psutil._psutil_posix' extension 06:20:31 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 06:20:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:20:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:20:31 INFO - ^ 06:20:31 INFO - 1 warning generated. 06:20:31 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 06:20:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:20:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:20:31 INFO - Successfully installed psutil 06:20:31 INFO - Cleaning up... 06:20:31 INFO - Return code: 0 06:20:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:31 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 0x10ca92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f817855b660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c936d30>, '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 0x10c79adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c92db20>, '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.0Fw3JhsLok/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.nUMn6qpQ5v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 06:20:31 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 06:20:31 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 06:20:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Fw3JhsLok/Render', 06:20:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:20:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:20:31 INFO - 'HOME': '/Users/cltbld', 06:20:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:20:31 INFO - 'LOGNAME': 'cltbld', 06:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:31 INFO - 'MOZ_NO_REMOTE': '1', 06:20:31 INFO - 'NO_EM_RESTART': '1', 06:20:31 INFO - 'PAGER': '/bin/cat', 06:20:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:32 INFO - 'PWD': '/builds/slave/test', 06:20:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:20:32 INFO - 'SHELL': '/bin/bash', 06:20:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nUMn6qpQ5v/Listeners', 06:20:32 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 06:20:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:20:32 INFO - 'USER': 'cltbld', 06:20:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:20:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:32 INFO - 'XPC_FLAGS': '0x0', 06:20:32 INFO - 'XPC_SERVICE_NAME': '0', 06:20:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:20:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:20:32 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 06:20:32 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 06:20:32 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 06:20:32 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 06:20:32 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 06:20:32 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 06:20:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:20:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:20:35 INFO - Installing collected packages: mozsystemmonitor 06:20:35 INFO - Running setup.py install for mozsystemmonitor 06:20:35 INFO - Successfully installed mozsystemmonitor 06:20:35 INFO - Cleaning up... 06:20:35 INFO - Return code: 0 06:20:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:20:35 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')]} 06:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:35 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')]} 06:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:35 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 0x10ca92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f817855b660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c936d30>, '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 0x10c79adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c92db20>, '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.0Fw3JhsLok/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.nUMn6qpQ5v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 06:20:35 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 06:20:35 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 06:20:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Fw3JhsLok/Render', 06:20:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:20:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:20:35 INFO - 'HOME': '/Users/cltbld', 06:20:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:20:35 INFO - 'LOGNAME': 'cltbld', 06:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:35 INFO - 'MOZ_NO_REMOTE': '1', 06:20:35 INFO - 'NO_EM_RESTART': '1', 06:20:35 INFO - 'PAGER': '/bin/cat', 06:20:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:35 INFO - 'PWD': '/builds/slave/test', 06:20:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:20:35 INFO - 'SHELL': '/bin/bash', 06:20:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nUMn6qpQ5v/Listeners', 06:20:35 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 06:20:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:20:35 INFO - 'USER': 'cltbld', 06:20:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:20:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:35 INFO - 'XPC_FLAGS': '0x0', 06:20:35 INFO - 'XPC_SERVICE_NAME': '0', 06:20:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:35 INFO - Downloading/unpacking blobuploader==1.2.4 06:20:35 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 06:20:35 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 06:20:35 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 06:20:35 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 06:20:35 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 06:20:35 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 06:20:39 INFO - Downloading blobuploader-1.2.4.tar.gz 06:20:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:20:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:20:39 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 06:20:39 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 06:20:39 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 06:20:39 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 06:20:39 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 06:20:39 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 06:20:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:20:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:20:40 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 06:20:40 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 06:20:40 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 06:20:40 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 06:20:40 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 06:20:40 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 06:20:40 INFO - Downloading docopt-0.6.1.tar.gz 06:20:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:20:40 INFO - Installing collected packages: blobuploader, requests, docopt 06:20:40 INFO - Running setup.py install for blobuploader 06:20:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:20:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:20:41 INFO - Running setup.py install for requests 06:20:41 INFO - Running setup.py install for docopt 06:20:41 INFO - Successfully installed blobuploader requests docopt 06:20:41 INFO - Cleaning up... 06:20:41 INFO - Return code: 0 06:20:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:41 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 0x10ca92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f817855b660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c936d30>, '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 0x10c79adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c92db20>, '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.0Fw3JhsLok/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.nUMn6qpQ5v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 06:20:41 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 06:20:41 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 06:20:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Fw3JhsLok/Render', 06:20:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:20:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:20:41 INFO - 'HOME': '/Users/cltbld', 06:20:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:20:41 INFO - 'LOGNAME': 'cltbld', 06:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:41 INFO - 'MOZ_NO_REMOTE': '1', 06:20:41 INFO - 'NO_EM_RESTART': '1', 06:20:41 INFO - 'PAGER': '/bin/cat', 06:20:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:41 INFO - 'PWD': '/builds/slave/test', 06:20:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:20:41 INFO - 'SHELL': '/bin/bash', 06:20:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nUMn6qpQ5v/Listeners', 06:20:41 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 06:20:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:20:41 INFO - 'USER': 'cltbld', 06:20:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:20:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:41 INFO - 'XPC_FLAGS': '0x0', 06:20:41 INFO - 'XPC_SERVICE_NAME': '0', 06:20:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:20:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:20:42 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Buq8lH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:20:42 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-SMQy_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:20:42 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-UNuoN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:20:42 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-HvlTqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:20:42 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-N8NRDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:20:42 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-U6z6Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:20:42 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-46TIkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:20:42 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-LWqAu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:20:42 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-dArOJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:20:42 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-1z7jmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:20:43 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-IiJYc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:20:43 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-UPscEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:20:43 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-iO65Kq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:20:43 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-mIB5iM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:20:43 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-CFg4Z5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:20:43 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-A0ocqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:20:43 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-sSPnjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:20:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:20:43 INFO - Running setup.py install for manifestparser 06:20:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:20:43 INFO - Running setup.py install for mozcrash 06:20:44 INFO - Running setup.py install for mozdebug 06:20:44 INFO - Running setup.py install for mozdevice 06:20:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:20:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:20:44 INFO - Running setup.py install for mozfile 06:20:44 INFO - Running setup.py install for mozhttpd 06:20:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:20:44 INFO - Running setup.py install for mozinfo 06:20:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:20:44 INFO - Running setup.py install for mozInstall 06:20:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:20:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:20:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:20:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:20:44 INFO - Running setup.py install for mozleak 06:20:45 INFO - Running setup.py install for mozlog 06:20:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:20:45 INFO - Running setup.py install for moznetwork 06:20:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:20:45 INFO - Running setup.py install for mozprocess 06:20:45 INFO - Running setup.py install for mozprofile 06:20:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:20:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:20:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:20:45 INFO - Running setup.py install for mozrunner 06:20:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:20:45 INFO - Running setup.py install for mozscreenshot 06:20:46 INFO - Running setup.py install for moztest 06:20:46 INFO - Running setup.py install for mozversion 06:20:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:20:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:20:46 INFO - Cleaning up... 06:20:46 INFO - Return code: 0 06:20:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:46 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 0x10ca92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f817855b660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c936d30>, '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 0x10c79adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c92db20>, '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.0Fw3JhsLok/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.nUMn6qpQ5v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 06:20:46 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 06:20:46 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 06:20:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Fw3JhsLok/Render', 06:20:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:20:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:20:46 INFO - 'HOME': '/Users/cltbld', 06:20:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:20:46 INFO - 'LOGNAME': 'cltbld', 06:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:46 INFO - 'MOZ_NO_REMOTE': '1', 06:20:46 INFO - 'NO_EM_RESTART': '1', 06:20:46 INFO - 'PAGER': '/bin/cat', 06:20:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:46 INFO - 'PWD': '/builds/slave/test', 06:20:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:20:46 INFO - 'SHELL': '/bin/bash', 06:20:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nUMn6qpQ5v/Listeners', 06:20:46 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 06:20:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:20:46 INFO - 'USER': 'cltbld', 06:20:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:20:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:46 INFO - 'XPC_FLAGS': '0x0', 06:20:46 INFO - 'XPC_SERVICE_NAME': '0', 06:20:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:20:46 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-eKSwq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:20:46 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)) 06:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:20:46 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-7kgC9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:20:46 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)) 06:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:20:46 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-H99YEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:20:47 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)) 06:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:20:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-1gumNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:20:47 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)) 06:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:20:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-LuQ_OR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:20:47 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)) 06:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:20:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-n3xKYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:20:47 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)) 06:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:20:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-DwIF_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:20:47 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)) 06:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:20:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-d8ncFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:20:47 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)) 06:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:20:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-gduHfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:20:47 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)) 06:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:20:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-VM5Rt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:20:47 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)) 06:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:20:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-n2M8mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:20:47 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)) 06:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:20:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-trhe_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:20:47 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)) 06:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:20:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-faTNv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:20:48 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)) 06:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:20:48 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-_FQEsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:20:48 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)) 06:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:20:48 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-5iqOjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:20:48 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)) 06:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:20:48 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-HrC2Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:20:48 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)) 06:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:20:48 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-iZnWtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:20:48 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)) 06:20:48 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)) 06:20:48 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)) 06:20:48 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)) 06:20:48 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)) 06:20:48 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)) 06:20:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:20:48 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 06:20:48 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 06:20:48 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 06:20:48 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 06:20:48 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 06:20:48 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 06:20:50 INFO - Downloading blessings-1.6.tar.gz 06:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:20:51 INFO - Installing collected packages: blessings 06:20:51 INFO - Running setup.py install for blessings 06:20:51 INFO - Successfully installed blessings 06:20:51 INFO - Cleaning up... 06:20:51 INFO - Return code: 0 06:20:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:20:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:20:51 INFO - Reading from file tmpfile_stdout 06:20:51 INFO - Current package versions: 06:20:51 INFO - blessings == 1.6 06:20:51 INFO - blobuploader == 1.2.4 06:20:51 INFO - docopt == 0.6.1 06:20:51 INFO - manifestparser == 1.1 06:20:51 INFO - mozInstall == 1.12 06:20:51 INFO - mozcrash == 0.17 06:20:51 INFO - mozdebug == 0.1 06:20:51 INFO - mozdevice == 0.48 06:20:51 INFO - mozfile == 1.2 06:20:51 INFO - mozhttpd == 0.7 06:20:51 INFO - mozinfo == 0.9 06:20:51 INFO - mozleak == 0.1 06:20:51 INFO - mozlog == 3.1 06:20:51 INFO - moznetwork == 0.27 06:20:51 INFO - mozprocess == 0.22 06:20:51 INFO - mozprofile == 0.28 06:20:51 INFO - mozrunner == 6.11 06:20:51 INFO - mozscreenshot == 0.1 06:20:51 INFO - mozsystemmonitor == 0.0 06:20:51 INFO - moztest == 0.7 06:20:51 INFO - mozversion == 1.4 06:20:51 INFO - psutil == 3.1.1 06:20:51 INFO - requests == 1.2.3 06:20:51 INFO - wsgiref == 0.1.2 06:20:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:20:51 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')]} 06:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:51 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')]} 06:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:51 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 0x10ca92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f817855b660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c936d30>, '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 0x10c79adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c92db20>, '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.0Fw3JhsLok/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.nUMn6qpQ5v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 06:20:51 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 06:20:51 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 06:20:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Fw3JhsLok/Render', 06:20:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:20:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:20:51 INFO - 'HOME': '/Users/cltbld', 06:20:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:20:51 INFO - 'LOGNAME': 'cltbld', 06:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:51 INFO - 'MOZ_NO_REMOTE': '1', 06:20:51 INFO - 'NO_EM_RESTART': '1', 06:20:51 INFO - 'PAGER': '/bin/cat', 06:20:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:51 INFO - 'PWD': '/builds/slave/test', 06:20:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:20:51 INFO - 'SHELL': '/bin/bash', 06:20:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nUMn6qpQ5v/Listeners', 06:20:51 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 06:20:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:20:51 INFO - 'USER': 'cltbld', 06:20:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:20:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:51 INFO - 'XPC_FLAGS': '0x0', 06:20:51 INFO - 'XPC_SERVICE_NAME': '0', 06:20:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:51 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)) 06:20:51 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)) 06:20:51 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)) 06:20:51 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)) 06:20:51 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)) 06:20:51 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)) 06:20:51 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)) 06:20:51 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)) 06:20:51 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)) 06:20:51 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)) 06:20:51 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)) 06:20:51 INFO - Cleaning up... 06:20:51 INFO - Return code: 0 06:20:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:20:51 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')]} 06:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:51 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')]} 06:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:51 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 0x10ca92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f817855b660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c936d30>, '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 0x10c79adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c92db20>, '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.0Fw3JhsLok/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.nUMn6qpQ5v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 06:20:51 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 06:20:51 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 06:20:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Fw3JhsLok/Render', 06:20:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:20:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:20:51 INFO - 'HOME': '/Users/cltbld', 06:20:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:20:51 INFO - 'LOGNAME': 'cltbld', 06:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:51 INFO - 'MOZ_NO_REMOTE': '1', 06:20:51 INFO - 'NO_EM_RESTART': '1', 06:20:51 INFO - 'PAGER': '/bin/cat', 06:20:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:51 INFO - 'PWD': '/builds/slave/test', 06:20:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:20:51 INFO - 'SHELL': '/bin/bash', 06:20:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nUMn6qpQ5v/Listeners', 06:20:51 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 06:20:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:20:51 INFO - 'USER': 'cltbld', 06:20:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:20:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:51 INFO - 'XPC_FLAGS': '0x0', 06:20:51 INFO - 'XPC_SERVICE_NAME': '0', 06:20:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:20:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:52 INFO - Downloading/unpacking jsonschema 06:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:20:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:20:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:20:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:20:54 INFO - Downloading/unpacking functools32 (from jsonschema) 06:20: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 06:20: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 06:20: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 06:20: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 06:20: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 06:20: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 06:20:55 INFO - Downloading functools32-3.2.3-2.tar.gz 06:20:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:20:55 INFO - warning: no files found matching '*.txt' 06:20:55 INFO - no previously-included directories found matching 'build' 06:20:55 INFO - no previously-included directories found matching 'dist' 06:20:55 INFO - no previously-included directories found matching '.git*' 06:20:55 INFO - Installing collected packages: jsonschema, functools32 06:20:55 INFO - Running setup.py install for functools32 06:20:55 INFO - warning: no files found matching '*.txt' 06:20:55 INFO - no previously-included directories found matching 'build' 06:20:55 INFO - no previously-included directories found matching 'dist' 06:20:55 INFO - no previously-included directories found matching '.git*' 06:20:55 INFO - Successfully installed jsonschema functools32 06:20:55 INFO - Cleaning up... 06:20:55 INFO - Return code: 0 06:20:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20: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')]} 06:20:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:56 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 0x10ca92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f817855b660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c936d30>, '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 0x10c79adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c92db20>, '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.0Fw3JhsLok/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.nUMn6qpQ5v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 06:20:56 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 06:20:56 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 06:20:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Fw3JhsLok/Render', 06:20:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:20:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:20:56 INFO - 'HOME': '/Users/cltbld', 06:20:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:20:56 INFO - 'LOGNAME': 'cltbld', 06:20:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:56 INFO - 'MOZ_NO_REMOTE': '1', 06:20:56 INFO - 'NO_EM_RESTART': '1', 06:20:56 INFO - 'PAGER': '/bin/cat', 06:20:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:56 INFO - 'PWD': '/builds/slave/test', 06:20:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:20:56 INFO - 'SHELL': '/bin/bash', 06:20:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nUMn6qpQ5v/Listeners', 06:20:56 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 06:20:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:20:56 INFO - 'USER': 'cltbld', 06:20:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:20:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:56 INFO - 'XPC_FLAGS': '0x0', 06:20:56 INFO - 'XPC_SERVICE_NAME': '0', 06:20:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:20:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:56 INFO - Downloading/unpacking flake8 06:20:56 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 06:20:56 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 06:20:56 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 06:20:56 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 06:20:56 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 06:20:56 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 06:20:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:20:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:20:59 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 06:20:59 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 06:20:59 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 06:20:59 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 06:20:59 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 06:20:59 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 06:20:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:20:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:20:59 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 06:20:59 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 06:20:59 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 06:20:59 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 06:20:59 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 06:20:59 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 06:21:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:21:00 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 06:21:00 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 06:21:00 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 06:21:00 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 06:21:00 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 06:21:00 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 06:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:21:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:21:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:21:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:21:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:21:00 INFO - no previously-included directories found matching 'docs/_build' 06:21:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:21:00 INFO - Running setup.py install for pep8 06:21:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:21:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:21:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:21:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:21:01 INFO - no previously-included directories found matching 'docs/_build' 06:21:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:21:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:21:01 INFO - Cleaning up... 06:21:01 INFO - Return code: 0 06:21:01 INFO - Running post-action listener: _resource_record_post_action 06:21:01 INFO - Running post-action listener: _start_resource_monitoring 06:21:01 INFO - Starting resource monitoring. 06:21:01 INFO - ##### 06:21:01 INFO - ##### Running install step. 06:21:01 INFO - ##### 06:21:01 INFO - Running pre-action listener: _resource_record_pre_action 06:21:01 INFO - Running main action method: install 06:21:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:21:01 INFO - Reading from file tmpfile_stdout 06:21:01 INFO - Detecting whether we're running mozinstall >=1.0... 06:21:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:21:01 INFO - Reading from file tmpfile_stdout 06:21:01 INFO - Output received: 06:21:01 INFO - Usage: mozinstall [options] installer 06:21:01 INFO - Options: 06:21:01 INFO - -h, --help show this help message and exit 06:21:01 INFO - -d DEST, --destination=DEST 06:21:01 INFO - Directory to install application into. [default: 06:21:01 INFO - "/builds/slave/test"] 06:21:01 INFO - --app=APP Application being installed. [default: firefox] 06:21:01 INFO - mkdir: /builds/slave/test/build/application 06:21:01 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'] 06:21:01 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 06:21:33 INFO - Reading from file tmpfile_stdout 06:21:33 INFO - Output received: 06:21:33 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 06:21:33 INFO - Running post-action listener: _resource_record_post_action 06:21:33 INFO - ##### 06:21:33 INFO - ##### Running run-tests step. 06:21:33 INFO - ##### 06:21:33 INFO - Running pre-action listener: _resource_record_pre_action 06:21:33 INFO - Running main action method: run_tests 06:21:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:21:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:21:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:21:33 INFO - 2016-03-30 06:21:33.842 screenresolution[1641:7660] starting screenresolution argv=screenresolution get 06:21:33 INFO - 2016-03-30 06:21:33.844 screenresolution[1641:7660] Display 0: 1600x1200x32@60 06:21:33 INFO - 2016-03-30 06:21:33.850 screenresolution[1642:7662] starting screenresolution argv=screenresolution list 06:21:33 INFO - Available Modes on Display 0 06:21:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:21:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:21:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:21:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:21:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:21:34 INFO - Intel Iris: 06:21:34 INFO - Chipset Model: Intel Iris 06:21:34 INFO - Type: GPU 06:21:34 INFO - Bus: Built-In 06:21:34 INFO - VRAM (Dynamic, Max): 1536 MB 06:21:34 INFO - Vendor: Intel (0x8086) 06:21:34 INFO - Device ID: 0x0a2e 06:21:34 INFO - Revision ID: 0x0009 06:21:34 INFO - Displays: 06:21:34 INFO - Display: 06:21:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:21:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:21:34 INFO - Display Serial Number: 1600x1200 60 06:21:34 INFO - Main Display: Yes 06:21:34 INFO - Mirror: Off 06:21:34 INFO - Online: Yes 06:21:34 INFO - Rotation: Supported 06:21:34 INFO - Return code: 0 06:21:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:21:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:21:34 INFO - Python 2.7.3 06:21:34 INFO - Return code: 0 06:21:34 INFO - grabbing minidump binary from tooltool 06:21: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')]} 06:21:34 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 0x10c936d30>, '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 0x10c79adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c92db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:21:34 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 06:21:34 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 06:21:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:21:34 INFO - Return code: 0 06:21:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:21:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:21:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:21:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:21:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:21:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:21:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:21:35 INFO - Return code: 0 06:21:35 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/THTHp_rfStu6IcFyl4nKcg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0150', '--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 06:21:35 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/THTHp_rfStu6IcFyl4nKcg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0150 --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 06:21:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Fw3JhsLok/Render', 06:21:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:21:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:21:35 INFO - 'HOME': '/Users/cltbld', 06:21:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:21:35 INFO - 'LOGNAME': 'cltbld', 06:21:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:21:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:35 INFO - 'MOZ_NO_REMOTE': '1', 06:21:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:21:35 INFO - 'NO_EM_RESTART': '1', 06:21:35 INFO - 'PAGER': '/bin/cat', 06:21:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:35 INFO - 'PWD': '/builds/slave/test', 06:21:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:21:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:21:35 INFO - 'SHELL': '/bin/bash', 06:21:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nUMn6qpQ5v/Listeners', 06:21:35 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 06:21:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:21:35 INFO - 'USER': 'cltbld', 06:21:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:21:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:35 INFO - 'XPC_FLAGS': '0x0', 06:21:35 INFO - 'XPC_SERVICE_NAME': '0', 06:21:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:21:35 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/THTHp_rfStu6IcFyl4nKcg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0150', '--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 06:21:35 INFO - mozversion application_buildid: 20160330041034 06:21:35 INFO - mozversion application_changeset: 435e4e199131c10583596524bf79cf1120e6a795 06:21:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:21:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:21:35 INFO - mozversion application_name: Firefox 06:21:35 INFO - mozversion application_remotingname: firefox-dev 06:21:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:21:35 INFO - mozversion application_vendor: Mozilla 06:21:35 INFO - mozversion application_version: 47.0a2 06:21:35 INFO - mozversion platform_buildid: 20160330041034 06:21:35 INFO - mozversion platform_changeset: 435e4e199131c10583596524bf79cf1120e6a795 06:21:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:21:35 INFO - mozversion platform_version: 47.0a2 06:21:35 INFO - using testdate: 1459344095 06:21:35 INFO - actual date: 1459344095 06:21:35 INFO - starting webserver on 'localhost:49270' 06:21:35 INFO - SUITE-START | Running 2 tests 06:21:35 INFO - TEST-START | dromaeo_css 06:21:35 INFO - operating with platform_type : mac_ 06:21:35 INFO - Initialising browser for dromaeo_css test... 06:21:35 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmp5d5l2W/profile http://localhost:49270/getInfo.html) 06:21:37 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 06:21:37 INFO - PROCESS | 1660 | colorDepth:24 06:21:37 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 06:21:37 INFO - PROCESS | 1660 | __metrics 06:21:37 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:21:37 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:21:38 INFO - TEST-INFO | 1660: exit 0 06:21:38 INFO - Browser initialized. 06:21:38 INFO - Running cycle 1/1 for dromaeo_css test... 06:21:38 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmp5d5l2W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:21:50 INFO - PROCESS | 1662 | RSS: Main: 210673664 06:21:50 INFO - PROCESS | 1662 | 06:22:41 INFO - PROCESS | 1662 | 1459344161698 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] 06:24:52 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 06:24:53 INFO - PROCESS | 1662 | RSS: Main: 318619648 06:24:53 INFO - PROCESS | 1662 | 06:27:55 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 06:27:56 INFO - PROCESS | 1662 | RSS: Main: 346275840 06:27:56 INFO - PROCESS | 1662 | 06:30:58 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 06:30:58 INFO - PROCESS | 1662 | RSS: Main: 347246592 06:30:58 INFO - PROCESS | 1662 | 06:34:00 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 06:34:01 INFO - PROCESS | 1662 | RSS: Main: 306348032 06:34:01 INFO - PROCESS | 1662 | 06:37:04 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 06:37:04 INFO - PROCESS | 1662 | RSS: Main: 310280192 06:37:04 INFO - PROCESS | 1662 | 06:40:07 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 06:40:07 INFO - PROCESS | 1662 | RSS: Main: 391733248 06:40:07 INFO - PROCESS | 1662 | 06:40:07 INFO - PROCESS | 1662 | __start_tp_report 06:40:07 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 06:40:07 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 06:40:07 INFO - PROCESS | 1662 | |i|pagename|runs| 06:40:07 INFO - PROCESS | 1662 | |0;dojo.html;3376.645452227516;3506.4389697648367;3523.0663874073366;3528.841202145903;3568.482570027346;5238.109521381365;5738.684372359518;5748.511376533;5756.7409466574;5780.8265752027455;5747.33905600855;5797.333306669734;5805.593608447411;5806.071028635419;5806.44838740319;5193.1171700810955;5208.5051920067535;5212.400573933989;5264.052470555299;5314.813981510648;5335.946640533583;5336.252924590561;5336.519713225809;5343.839684809462;5347.25138480613;5253.816116435925;5312.256284120226;5314.627976041678;5342.171963345668;5345.732713364336;4618.5682438443855;5322.281491998569;5356.54469370104;5364.356277246756;5377.704226267573;5048.974755126201;5200.973995130038;5223.947760522422;5247.291615631879;5288.23320618512;5684.062129748587;5722.341930677983;5727.713614319267;5737.2254745609225;5752.913706294409;6269.216347956505;6354.3010268870385;6354.650494222862;6356.777512787076;6358.618482891041;6267.59260648061;6314;6349.36506349366;6367.681615919186;6388.2334119905445;5944.375840536768;5968.045112782021;5980.55145864062;5983.611065280743;5991.071383935497;5865.912011319749;6364.363563643598;6377.266614339317;6381.489480841522;6383.106365108889;6169.876602467925;6176.752929882844;6306.779262725782;6313.084602732578;6314.747410103544;6365.522585806083;6365.61806291624;6374.776882809079;6381.521385896076;6404.263509696351;6114.206128133723;6287.025511045796;6313.621182729051;6368.936310636835;6378.45783108441;6188.535859810532;6302.023186406022;6334.3032266450655;6342.809715708536;6351.682415879188;4128.587141285908;4942.950570494249;4957.231629097496;4963.61410040719;4976;4451.376807246988;4481.282994720894;4509.368688383629;4519.322101684708;4559.54404559548;5738.053221218535;5779.88440231193;5801.100829371454;5833.649981001068;5842.5618078644275;6261.9605036210305;6311.842203944846;6329.90505142414;6347.1114044033875;6347.841303967438;5610.354809196913;5730.942690573041;5777.62445441045;5795.565332599987;5832.154337621021;5401.432849550819;5448.863778405493;5454.672719636835;5475.06923822951;5494.972525137348;6320.589161704658;6340.8414789629705;6367.4906007519285;6379.425851673279;6386.393292637378;6251;6251.281102673069;6350.618962862243;6354.332795056453;6362.331955144643;6312.652804095819;6365.108884756045;6381.904271436025;6383.8084857452495;6396;6273.466755325849;6325.1144839721555;6367.968160159169;6374.58565193261;6382.393672601282;6232.09634602971;6257.4681152102585;6261.123442718114;6353.5870168438905;6364.554481186273;6071.908921366095;6136.203000408158;6164.260288765377;6170.413810687977;6176.752929882754;6127.632342059491;6141.560725993458;6146.0473626587955;6163;6164.260288765377;5910.172575839472;5990.191324171181;6018.608790428608;6025.78909738157;6048.455638992512;6195.969020155051;6197.566170368031;6203.2245969253845;6218.098375735583;6222.346653601307;6086.908696369469;6107.358727333566;6112.358202388685;6120.632762034292;6123.357047509948 06:40:07 INFO - PROCESS | 1662 | |1;ext.html;495.36593160754245;590.4508806809665;596;658.6015460646311;659.7427003468647;39908.40137397938;40809.3878591821;40850.7957460213;40860.79569602155;40868.386974195375;39429.014274643145;43955.78022109893;44791.552084479146;44857.7757111214;44886.55113448865;9292.210162136227;9904.059114384121;9916.652917147901;9920.355176913514;9921.603135874557;8678.739637810875;9377.437353758762;9529.80940381192;9814.754631134243;9821.558029888673;9785.07041831025;9842.458664773434;9847.507624618776;9857.457839818808;9876.703698889009;9762.121409073183;9792.951035244778;9815.214782817393;9819.312648114636;9821.459819709913;9813.067758562926;9933.106020458194;9949.10458058771;9951.20390368776;9979.451130187837;43537.56462435367;43739.34390984138;43744;43815.34276985848;43858;3209.2297848516423;3210.4542227821325;3242.9351412971846;3256.8371581420834;3808.5239345081864;29709.757523370678;30115.397692046256;30198;30396.392072158655;30632.54051189234;2798.8460634665084;2815.6480439945008;2834.362268489594;2869.253993961564;2902.3034471726846;483143.16856831335;484108;484499;484656;485885;72384.63807680928;72662.63668681623;72823.90764138542;72833.6358318205;72879.90680139803;77271;77589.61205193937;80034.79947800787;80228;80744;16475.505734827733;18628.441146765617;18841.528961776065;18852.680312378277;18862.15120319589;14112.50606228777;14188.64528386778;14205.857941420454;14229.715405691828;14239;18917.527061823566;19085.61828763417;19668.21327146898;23056.654150187762;23754.812259386963;7495.925040749632;9227.492487913229;9434.716958491255;9440.395601327988;9447.149756521945;967.1972263021676;997.3168379659957;1037.9325343852624;1056.5087234436023;1092.710940070394;30117.09648710542;30481.933132340262;30563.38873222523;30884.91902783392;31243.68756312453;1129.412705393191;1166.5567084508002;1171.701216189866;1201.387292480841;1234.1299383934304;15498.690026199638;15681.451149209723;15831.050136991817;15928.642534160716;15997.60005999836;552072;555868;557925;558968;559112;63092.68453657702;63606;63921.36078639247;64168.67915660392;64294.35705642977;1405.3394904394918;1422.8648278413534;1540.3376548084207;1557.4548907882377;1657.2790835986384;28223.012194573912;28763.5685464714;29618.111456656334;31215;31423.37153256968;54592.454075458736;55183.44816551783;55593.722031391204;55647;55665;377189;381411;381675;381870;383757;29933.70066299309;34107.48838767371;48531.27203092027;48730.26904596363;49041.26438103503;47085;47868.76065619649;47906.04187916292;48057;48106;38512.03719907025;38548.80725596354;38887;39022.63420780259;39828.60171398249;37868.810655947644;38177.42733858939;38851.417228741026;38872.41691374575;38888.611113888495;39820.08875754372;40137.799311003255;41411;41418.96452588589;41423;33157;36393.256411789494;36833.81583092068;38025.80987095047;38383.04042398962;26846.597301040892;27186.72813271842;27192.456150876475;27230.72769272282;27390.5891411633 06:40:07 INFO - PROCESS | 1662 | |2;jquery.html;320.6969413903861;366.6974745834687;376.4065588098005;379.71521358980766;381.9350710379239;19870.90710010949;20435.284765033226;21117.260895868647;21914.561708765814;21942.23202187922;21332.680009799828;21387.144514219413;21686.24098156565;21687.02408391626;21757.238496652582;5707.258056452666;5980.79067232647;6023.638581685091;6027.5479339049525;6031.819045428622;3909.530856297248;4089.4683691120113;5549.6115271930985;7282.854342913139;7648.311651951323;7267;7632.542047477142;7636.045494313211;7644.885326720076;7655.732049378273;7477.700891964315;7495.325420712162;7546.056742907137;7554.169041405414;7557.206493318205;4519.07358991406;6923.376896079377;7209.567425954459;7221.350078492961;7228.963855180743;27705.44589108227;28638.570421443696;29051.56422653662;29363.119106426842;29491.820327186888;2550.846949183055;2738.178546436081;2868.6127372804613;3185.1718553176343;3212.084555901557;15523.301451434712;15604.60988475286;15789.526314210592;16132;16473.67052658952;1871.429214089702;1944.212593899473;1959.304446921351;2012.0442789674787;2055.856090073695;115980;127249;128012.35993820065;128382;131149.6885031147;20569.074391652113;20732.067056982472;20826.1669533217;20958.16167353319;21016.894915525325;30681.079567613007;30785.38429231403;31391.21521961969;31413.685863141076;31419.371612567622;9854.669619601405;11224.270422422516;11512.136589755803;11539.307641541534;11774.705632359088;9824.361416507903;9838.212942964547;9840.753981150528;9879.407235565888;9947.55236014381;9203.677871274607;9257.907420925705;9347.719568412958;9385.5307234638;9411.811763764686;3013.412384584985;3239.0121013091234;3309.652486488932;3535.1338921964284;3664.120611053328;411.29668267263315;413.3469118792301;432.5285438871645;786.8072322281078;952.476138124029;11692;12016;12064.457099430547;12092.455839487244;12155.5137794489;457.9564941330635;458.55291091185825;461.89145550795536;463.1408736793267;474.29803890242636;6132.202813634199;6222.12890195373;6222.751089956441;6273.435390814849;6314.336994615591;674253;685307;686538;694397;703100.1399160463;127788;129167;129959;131424;132567.33716331355;459.0612198054986;460.61768731953066;463.27960022165183;464.5169024214779;464.94420669519195;9182;10705.411202383944;11176.10591152722;11207.327560346404;11302.886971130183;51288.74355628198;51973.22040169476;52218;52689.47310526999;53004.73497632487;76685.84971225324;78263;82093;84777;85908.71136932826;7087.149542054986;8077.313428358655;8148.185181482041;8219.383546234176;8336;9170.403923744936;11384.544618215179;12063.939680301894;12740.745185096432;13278.734425311633;11269.830952535554;11348.489317980875;11350.829737554108;11356.034737047443;11364.94317528407;11220.046296064926;11253;11376.601818936297;11441.771164576829;11704.419903313285;10895.891041089488;11602.18784685064;11897.643070707893;11904.821427678418;12115.81826272589;8035.67857285702;8111.594420278844;8251.95874020626;8275.83448331042;8480.74557763268;11901.523939042687;11973.880261197277;12064.396780161132;12117.878821211674;12221.69445763863 06:40:07 INFO - PROCESS | 1662 | |3;mootools.html;1496.4163976049335;1615.6203292226326;1645.4981230724627;1948.6102779444107;2046.0153650958564;8225.218604232596;8826.823463530734;8999.685011024616;9003.324750643695;9010.369274150811;8813.294936405087;9060.365774395796;9084.909150908505;9095.135962083592;9095.54522273887;2253.256425379621;2508.5233805576927;2520.6975162980466;2535.5816290312077;2554.6551215585937;2164.7618761936174;2564;2567.281161274846;2567.8074144439147;2569.02377096703;2508.686414198225;2568.8073394495395;2589.4173810892494;2589.7669209771116;2591.1449221756775;2200.7249093863265;2487.6641653376832;2569.730178331267;2575.9227223183148;2576.059738195564;2542.6313184588316;2560.667113275281;2572.4340645058055;2580.909668161605;2591.119019533349;9115.088491150831;9219.723408297761;9221.907780922173;9224.631014759469;9248.722538323862;5517.44825517449;5663.773449062032;5697.515711164556;5702.173184888209;5733.741981610796;3643.234920666663;3714.832832522516;3822.197338558906;3822.4075268333454;3822.9235415291537;1044.952977116024;1075.4353964168795;1081.2107161771871;1095.9287646302964;1117.0951529261242;10546.05085542305;10681.824999250077;12360.876391236152;12477.190807332976;12518.311492867888;5036.924446133311;5044.520770526794;5114.667546609458;5121.308623335802;5160.148575485078;10499;10544.578216871392;10550.050495455293;10558.577656893793;10558.736031599117;5662.037453632893;5676.403977582377;5682.460166284196;5690.260266165455;5691.943080569141;4584.15193189261;4768.0702263059065;4862.222044472938;4914.238293064581;4921.9507804922205;4044.295597330519;4085.7752823594988;4139.19285739284;4181.456410666594;4184.895377615584;1316.1559888579234;1345.5156143788424;1350.216874212954;1353.9932300338633;1358.0697222402687;1173.5975509266516;1192.4157162990073;1201.8497687789027;1390.513320337894;1426.12293439536;8377.287930525974;8390;8435.325173986066;8438.493690378597;8488.533130677872;507.9187330027178;523.4843678976206;525.6373102559222;525.8343621759134;527.7123967437756;6301.149344838388;6349.428551430301;6390.7763228286785;6395.904061439082;6404.42360187576;10597.470126493645;11050.889491104987;11063.446827658585;11089.500972456259;11095.001449869389;10414.583416663248;10818.026377625894;10883.78232435347;10890.019898209199;10935.507902144423;8412.158784121539;8450.661973521113;8606.26846718036;8613.741587752378;8652.394332396672;8042.235987581171;8167.591620418836;8194.631241594023;8209.220124088202;8250.711225107092;9282.953585232031;9568.330216884751;9570.808583828146;9733.124018838338;9740;9670;9970.700878973643;10052.045055719695;10151.187904967732;10181.981801819758;7486.850262994601;7681.308682218627;7710.961445192738;7719.691212351443;7797;8495.150484951455;8509.978802543734;8559.400841941004;8578.313734901069;8581.399302048796;7426.777196683892;7587.734429295169;7651.923480765121;7658.578778167254;7661.425393095428;7393.260673932778;7439.181690014202;7489.176190618919;7519.248075192437;7582.62086895642;7987.92012079895;8018.799530011796;8033.758987230392;8051.677932882853;8066.637001334837;7196.172440169447;7197.280271972971;7222.96388518054;7278.199398066315;7291.489595728461;7360;7379;7415;7426.962865185639;7434.3309102181065 06:40:07 INFO - PROCESS | 1662 | |4;prototype.html;329.0769391855844;335.3845693153064;336.56919143496316;338.06356392791974;341.5969156395454;6666.766663166784;6677.465802735769;6713.7985860424205;6736.427403670687;6741.123653924995;5348.893022139555;6652.467802575795;6660.9666951665295;6667.366600172976;6673.09913161723;4733.100710864925;4805.7597120143855;4908.631852611051;4919.754012299389;4956.702597844141;4890.926636100461;4900.289458028584;4918.631102667297;4928.383952005999;4957.925631115536;4881.145799485093;4891.241857512091;4897.628663974093;4915.361003069596;4925.630577706668;4659.906801863961;4768.737719425448;4892.584130348924;4911.263310503417;4922.556969872693;4232.365145228209;4236.51280102789;4236.555161708007;4243.448351714257;4253.319468884994;6326.335734747831;6373.904391434132;6382.776602818925;6389.137466442017;6430.58201216924;5839.474447299721;5843.298804143487;5845.123231515264;5853.356130825606;5858.179854820329;6732.1921369435495;7068.752593659197;7077.009218709385;7082.804330657461;7084.291570842926;4567.880869187071;4588.816447342136;4612.238980568202;4634.814607415733;4638.281066434708;7297.722898492796;7376.336129748348;7466.738664146783;7471.364933980618;7480.326770590673;3954.62431069048;4674.205385084544;4688.507706690816;4691.81232750693;4703.835365762182;4725.64557658177;4735.431748190239;4735.810567577328;4738.147133516;4747.098051370229;5629.774809007594;5655.1799989001365;5662.886742265132;5674.404187560329;5675.829725108253;6838.384545390939;7045.084139061889;7099.787006389816;7150.678219480136;7152.678129484186;1596.1859451679727;1628.51958672192;1631.5350125214495;1634.1910754176758;1635.8364163583785;984.0356450678375;1018.9133923616575;1046.1108058150512;1046.7173863056933;1073.098597178374;6240.812775616739;6259.186305780219;6271.62370257786;6272.2159730033745;6352.968235158794;7268.400951790598;7282.96358518204;7286.453515986323;7308.890366644505;7332.486725929134;6483.837904052342;6517.869642607121;6521.934780652227;6529.955207166926;6534.640594767334;3846.8845934622004;3894.045958740127;3897.279003384383;3899.590542992945;3900.531936167621;7352.19125896151;7635.618219089023;7723.459357845009;7743.341815945595;7747.147813740484;7548.471606987568;7628.69485220596;7634.770956871303;7637.19809420014;7637.770866874002;7688.923550702906;7694.153643099255;7697.4226932980255;7708.884366734504;7716.922830771845;7101.183363913009;7342.559446433231;7383.114026316876;7411.814704632212;7417.592032438268;7193.964030179815;7236.782896513113;7239.565626062453;7260.16508101554;7279.199288078201;7648.388128949559;7670.386369090571;7673;7675.961620191863;7676.117246516722;4595.701279416827;4645.721256724607;4649.814007439664;4654.138984287918;4658.0218154188;7106.609136497335;7310.305520975498;7327.596982166032;7329.52358096722;7340.779776606711;7035.788926332219;7095.751648692271;7116.893246601202;7120.1099862517185;7128.394086502705;7065.0815393998455;7074.903389974562;7077.752278670222;7080.893786593102;7093.893591596027;6921.861562768616;6933;6935.7225710971;6938.167419909643;6950.895736564057;6796.72813087471;7079.398251148504;7087.184973727881;7096.822579435556;7108.502404831819;6636.13730215069;6826.761063362758;6884.621345826027;6901;6964.582125072512 06:40:07 INFO - PROCESS | 1662 | |5;yui.html;709.9254578269282;762.249184553215;767.6392095715012;776.4332037612543;778.8442311537694;12117.272963622188;15177.317020734066;15216.467423640175;15217.695646087072;15228.92385538072;14385.64035899103;14421.78367324491;14455.132692038485;14461.78307325391;14475.565733028026;776.3827756933251;779.7543773711291;927.638221093774;931.7670582354411;949.9192568631657;919.56320747645;924.0251534630962;924.089771574998;925.6019911438079;945.3524335829944;976.9804603907918;992.6128809764198;996.4419924842075;999.8900120986685;1016.7153197104823;814.4868732698362;819.5246756880995;976.9853452198187;981.8919918808925;1007.8085163818888;744.9664765085585;750.8761054426013;752.8268498245434;753.4311594745986;755.0674916478146;15548.455804046916;15635.983661061995;15642.2178891055;15644.921775391163;15652.68694626101;10938.234323597351;13278;13411.329433528383;13651.180929144184;13679.931600341935;8576.614052367659;10308.381497110197;10326.535305911251;10453.372797632166;10585.259031867772;3542.8405721742324;3562.5012498250267;3682.355587772129;3751.306008388457;3812.4471951567143;82377;82675.5866220671;84804;85051;85101.14898851055;8926.776830579158;9042.683506077256;9191.218746406497;9418.152366287068;9570.95214523923;21328.466788330104;21389.78610213878;21435.821029843195;21487.46281342979;21514;7568.659410326549;7605.923940760632;7649.04386951631;7674.117476490275;7731.420143489261;3800.726756536536;4210.305299625527;4243.766592837362;4249.766262855511;4297.355396690521;3706.9073273168387;3811.2377524495214;3819.1788765415567;3819.6371344722206;3821.102041020358;664.9434798042221;668.3383450384084;670.7752902777527;677.1738479055545;687.8521117959663;506.20020367818756;530.4165418040125;540.8755986123214;580.2398857496693;636.4717284653726;7902.723404680809;8317.20986506293;8450.323974082059;8473.384817106316;8520.8721869172;523.2517499975072;603.5111559636621;606.9878602427926;613.0191693290699;624.2883113250898;3766.642168993941;4042.312806822847;4218.936715949263;4265.765382903908;4394.890127746768;99321;99771.50114249383;100751;100995.49502252441;101139.49430252802;78985;79739;80101;80474.59762701149;85257;73923.5215295691;74855.25144748592;75062.99999999891;75991.24008759842;76293.6185319081;8067.435279530377;8586.484810911365;8620.181082797124;8644.870326944974;8670.2212318956;33132;41170.794146029075;42572.5742742581;42846.92882677958;43742.781286094636;63154;65165.370865728735;65955.01067484087;66386.33613663995;66970.33029669641;11006.339619622848;11263.605773797877;11400.429978501208;11435.085193184692;11560.30638161713;11920.284782913053;11993.880061199276;12034.097442691658;12092;12912.354382281037;11330.490127944428;11592.710182245512;11774.470148843151;11822.940885295518;11999.82000270014;10036.749081273027;11472.082233421474;11799.410029498662;11883.584074557695;12133.939330303292;11246.887531124585;11723.531058757555;11759.353235572125;11783.705407364885;11810.173287869766;9691.9030809691;9761.316707830383;9806.068423499755;10018.499075046073;10141.340812847142;9290;9661.3237073407;9862.630827783143;9966.451845148586;9970.03135791687 06:40:07 INFO - PROCESS | 1662 | __end_tp_report 06:40:07 INFO - PROCESS | 1662 | __start_cc_report 06:40:07 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1008 06:40:07 INFO - PROCESS | 1662 | __end_cc_report 06:40:07 INFO - PROCESS | 1662 | __startTimestamp1459345207855__endTimestamp 06:40:07 INFO - PROCESS | 1662 | 06:40:07 INFO - PROCESS | 1662 | ------- Summary: start ------- 06:40:07 INFO - PROCESS | 1662 | Number of tests: 6 06:40:07 INFO - PROCESS | 1662 | 06:40:07 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5819.29 Median:6086.91 stddev:654.57 (10.8%) stddev-sans-first:627.90 06:40:07 INFO - PROCESS | 1662 | Values: 3376.6 3506.4 3523.1 3528.8 3568.5 5238.1 5738.7 5748.5 5756.7 5780.8 5747.3 5797.3 5805.6 5806.1 5806.4 5193.1 5208.5 5212.4 5264.1 5314.8 5335.9 5336.3 5336.5 5343.8 5347.3 5253.8 5312.3 5314.6 5342.2 5345.7 4618.6 5322.3 5356.5 5364.4 5377.7 5049.0 5201.0 5223.9 5247.3 5288.2 5684.1 5722.3 5727.7 5737.2 5752.9 6269.2 6354.3 6354.7 6356.8 6358.6 6267.6 6314.0 6349.4 6367.7 6388.2 5944.4 5968.0 5980.6 5983.6 5991.1 5865.9 6364.4 6377.3 6381.5 6383.1 6169.9 6176.8 6306.8 6313.1 6314.7 6365.5 6365.6 6374.8 6381.5 6404.3 6114.2 6287.0 6313.6 6368.9 6378.5 6188.5 6302.0 6334.3 6342.8 6351.7 4128.6 4943.0 4957.2 4963.6 4976.0 4451.4 4481.3 4509.4 4519.3 4559.5 5738.1 5779.9 5801.1 5833.6 5842.6 6262.0 6311.8 6329.9 6347.1 6347.8 5610.4 5730.9 5777.6 5795.6 5832.2 5401.4 5448.9 5454.7 5475.1 5495.0 6320.6 6340.8 6367.5 6379.4 6386.4 6251.0 6251.3 6350.6 6354.3 6362.3 6312.7 6365.1 6381.9 6383.8 6396.0 6273.5 6325.1 6368.0 6374.6 6382.4 6232.1 6257.5 6261.1 6353.6 6364.6 6071.9 6136.2 6164.3 6170.4 6176.8 6127.6 6141.6 6146.0 6163.0 6164.3 5910.2 5990.2 6018.6 6025.8 6048.5 6196.0 6197.6 6203.2 6218.1 6222.3 6086.9 6107.4 6112.4 6120.6 6123.4 06:40:07 INFO - PROCESS | 1662 | 06:40:07 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:64490.23 Median:40855.80 stddev:127272.18 (311.5%) stddev-sans-first:127538.52 06:40:07 INFO - PROCESS | 1662 | Values: 495.4 590.5 596.0 658.6 659.7 39908.4 40809.4 40850.8 40860.8 40868.4 39429.0 43955.8 44791.6 44857.8 44886.6 9292.2 9904.1 9916.7 9920.4 9921.6 8678.7 9377.4 9529.8 9814.8 9821.6 9785.1 9842.5 9847.5 9857.5 9876.7 9762.1 9793.0 9815.2 9819.3 9821.5 9813.1 9933.1 9949.1 9951.2 9979.5 43537.6 43739.3 43744.0 43815.3 43858.0 3209.2 3210.5 3242.9 3256.8 3808.5 29709.8 30115.4 30198.0 30396.4 30632.5 2798.8 2815.6 2834.4 2869.3 2902.3 483143.2 484108.0 484499.0 484656.0 485885.0 72384.6 72662.6 72823.9 72833.6 72879.9 77271.0 77589.6 80034.8 80228.0 80744.0 16475.5 18628.4 18841.5 18852.7 18862.2 14112.5 14188.6 14205.9 14229.7 14239.0 18917.5 19085.6 19668.2 23056.7 23754.8 7495.9 9227.5 9434.7 9440.4 9447.1 967.2 997.3 1037.9 1056.5 1092.7 30117.1 30481.9 30563.4 30884.9 31243.7 1129.4 1166.6 1171.7 1201.4 1234.1 15498.7 15681.5 15831.1 15928.6 15997.6 552072.0 555868.0 557925.0 558968.0 559112.0 63092.7 63606.0 63921.4 64168.7 64294.4 1405.3 1422.9 1540.3 1557.5 1657.3 28223.0 28763.6 29618.1 31215.0 31423.4 54592.5 55183.4 55593.7 55647.0 55665.0 377189.0 381411.0 381675.0 381870.0 383757.0 29933.7 34107.5 48531.3 48730.3 49041.3 47085.0 47868.8 47906.0 48057.0 48106.0 38512.0 38548.8 38887.0 39022.6 39828.6 37868.8 38177.4 38851.4 38872.4 38888.6 39820.1 40137.8 41411.0 41419.0 41423.0 33157.0 36393.3 36833.8 38025.8 38383.0 26846.6 27186.7 27192.5 27230.7 27390.6 06:40:07 INFO - PROCESS | 1662 | 06:40:07 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:38760.81 Median:3422.39 stddev:114298.49 (3339.7%) stddev-sans-first:114582.68 06:40:07 INFO - PROCESS | 1662 | Values: 320.7 366.7 376.4 379.7 381.9 19870.9 20435.3 21117.3 21914.6 21942.2 21332.7 21387.1 21686.2 21687.0 21757.2 5707.3 5980.8 6023.6 6027.5 6031.8 3909.5 4089.5 5549.6 7282.9 7648.3 7267.0 7632.5 7636.0 7644.9 7655.7 7477.7 7495.3 7546.1 7554.2 7557.2 4519.1 6923.4 7209.6 7221.4 7229.0 27705.4 28638.6 29051.6 29363.1 29491.8 2550.8 2738.2 2868.6 3185.2 3212.1 15523.3 15604.6 15789.5 16132.0 16473.7 1871.4 1944.2 1959.3 2012.0 2055.9 115980.0 127249.0 128012.4 128382.0 131149.7 20569.1 20732.1 20826.2 20958.2 21016.9 30681.1 30785.4 31391.2 31413.7 31419.4 9854.7 11224.3 11512.1 11539.3 11774.7 9824.4 9838.2 9840.8 9879.4 9947.6 9203.7 9257.9 9347.7 9385.5 9411.8 3013.4 3239.0 3309.7 3535.1 3664.1 411.3 413.3 432.5 786.8 952.5 11692.0 12016.0 12064.5 12092.5 12155.5 458.0 458.6 461.9 463.1 474.3 6132.2 6222.1 6222.8 6273.4 6314.3 674253.0 685307.0 686538.0 694397.0 703100.1 127788.0 129167.0 129959.0 131424.0 132567.3 459.1 460.6 463.3 464.5 464.9 9182.0 10705.4 11176.1 11207.3 11302.9 51288.7 51973.2 52218.0 52689.5 53004.7 76685.8 78263.0 82093.0 84777.0 85908.7 7087.1 8077.3 8148.2 8219.4 8336.0 9170.4 11384.5 12063.9 12740.7 13278.7 11269.8 11348.5 11350.8 11356.0 11364.9 11220.0 11253.0 11376.6 11441.8 11704.4 10895.9 11602.2 11897.6 11904.8 12115.8 8035.7 8111.6 8252.0 8275.8 8480.7 11901.5 11973.9 12064.4 12117.9 12221.7 06:40:07 INFO - PROCESS | 1662 | 06:40:07 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:6218.14 Median:525.74 stddev:3273.23 (622.6%) stddev-sans-first:3263.17 06:40:07 INFO - PROCESS | 1662 | Values: 1496.4 1615.6 1645.5 1948.6 2046.0 8225.2 8826.8 8999.7 9003.3 9010.4 8813.3 9060.4 9084.9 9095.1 9095.5 2253.3 2508.5 2520.7 2535.6 2554.7 2164.8 2564.0 2567.3 2567.8 2569.0 2508.7 2568.8 2589.4 2589.8 2591.1 2200.7 2487.7 2569.7 2575.9 2576.1 2542.6 2560.7 2572.4 2580.9 2591.1 9115.1 9219.7 9221.9 9224.6 9248.7 5517.4 5663.8 5697.5 5702.2 5733.7 3643.2 3714.8 3822.2 3822.4 3822.9 1045.0 1075.4 1081.2 1095.9 1117.1 10546.1 10681.8 12360.9 12477.2 12518.3 5036.9 5044.5 5114.7 5121.3 5160.1 10499.0 10544.6 10550.1 10558.6 10558.7 5662.0 5676.4 5682.5 5690.3 5691.9 4584.2 4768.1 4862.2 4914.2 4922.0 4044.3 4085.8 4139.2 4181.5 4184.9 1316.2 1345.5 1350.2 1354.0 1358.1 1173.6 1192.4 1201.8 1390.5 1426.1 8377.3 8390.0 8435.3 8438.5 8488.5 507.9 523.5 525.6 525.8 527.7 6301.1 6349.4 6390.8 6395.9 6404.4 10597.5 11050.9 11063.4 11089.5 11095.0 10414.6 10818.0 10883.8 10890.0 10935.5 8412.2 8450.7 8606.3 8613.7 8652.4 8042.2 8167.6 8194.6 8209.2 8250.7 9283.0 9568.3 9570.8 9733.1 9740.0 9670.0 9970.7 10052.0 10151.2 10182.0 7486.9 7681.3 7711.0 7719.7 7797.0 8495.2 8510.0 8559.4 8578.3 8581.4 7426.8 7587.7 7651.9 7658.6 7661.4 7393.3 7439.2 7489.2 7519.2 7582.6 7987.9 8018.8 8033.8 8051.7 8066.6 7196.2 7197.3 7223.0 7278.2 7291.5 7360.0 7379.0 7415.0 7427.0 7434.3 06:40:07 INFO - PROCESS | 1662 | 06:40:07 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:5811.56 Median:6644.30 stddev:1855.73 (27.9%) stddev-sans-first:1814.74 06:40:07 INFO - PROCESS | 1662 | Values: 329.1 335.4 336.6 338.1 341.6 6666.8 6677.5 6713.8 6736.4 6741.1 5348.9 6652.5 6661.0 6667.4 6673.1 4733.1 4805.8 4908.6 4919.8 4956.7 4890.9 4900.3 4918.6 4928.4 4957.9 4881.1 4891.2 4897.6 4915.4 4925.6 4659.9 4768.7 4892.6 4911.3 4922.6 4232.4 4236.5 4236.6 4243.4 4253.3 6326.3 6373.9 6382.8 6389.1 6430.6 5839.5 5843.3 5845.1 5853.4 5858.2 6732.2 7068.8 7077.0 7082.8 7084.3 4567.9 4588.8 4612.2 4634.8 4638.3 7297.7 7376.3 7466.7 7471.4 7480.3 3954.6 4674.2 4688.5 4691.8 4703.8 4725.6 4735.4 4735.8 4738.1 4747.1 5629.8 5655.2 5662.9 5674.4 5675.8 6838.4 7045.1 7099.8 7150.7 7152.7 1596.2 1628.5 1631.5 1634.2 1635.8 984.0 1018.9 1046.1 1046.7 1073.1 6240.8 6259.2 6271.6 6272.2 6353.0 7268.4 7283.0 7286.5 7308.9 7332.5 6483.8 6517.9 6521.9 6530.0 6534.6 3846.9 3894.0 3897.3 3899.6 3900.5 7352.2 7635.6 7723.5 7743.3 7747.1 7548.5 7628.7 7634.8 7637.2 7637.8 7688.9 7694.2 7697.4 7708.9 7716.9 7101.2 7342.6 7383.1 7411.8 7417.6 7194.0 7236.8 7239.6 7260.2 7279.2 7648.4 7670.4 7673.0 7676.0 7676.1 4595.7 4645.7 4649.8 4654.1 4658.0 7106.6 7310.3 7327.6 7329.5 7340.8 7035.8 7095.8 7116.9 7120.1 7128.4 7065.1 7074.9 7077.8 7080.9 7093.9 6921.9 6933.0 6935.7 6938.2 6950.9 6796.7 7079.4 7087.2 7096.8 7108.5 6636.1 6826.8 6884.6 6901.0 6964.6 06:40:07 INFO - PROCESS | 1662 | 06:40:07 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:18622.76 Median:591.88 stddev:26666.26 (4505.4%) stddev-sans-first:26707.14 06:40:07 INFO - PROCESS | 1662 | Values: 709.9 762.2 767.6 776.4 778.8 12117.3 15177.3 15216.5 15217.7 15228.9 14385.6 14421.8 14455.1 14461.8 14475.6 776.4 779.8 927.6 931.8 949.9 919.6 924.0 924.1 925.6 945.4 977.0 992.6 996.4 999.9 1016.7 814.5 819.5 977.0 981.9 1007.8 745.0 750.9 752.8 753.4 755.1 15548.5 15636.0 15642.2 15644.9 15652.7 10938.2 13278.0 13411.3 13651.2 13679.9 8576.6 10308.4 10326.5 10453.4 10585.3 3542.8 3562.5 3682.4 3751.3 3812.4 82377.0 82675.6 84804.0 85051.0 85101.1 8926.8 9042.7 9191.2 9418.2 9571.0 21328.5 21389.8 21435.8 21487.5 21514.0 7568.7 7605.9 7649.0 7674.1 7731.4 3800.7 4210.3 4243.8 4249.8 4297.4 3706.9 3811.2 3819.2 3819.6 3821.1 664.9 668.3 670.8 677.2 687.9 506.2 530.4 540.9 580.2 636.5 7902.7 8317.2 8450.3 8473.4 8520.9 523.3 603.5 607.0 613.0 624.3 3766.6 4042.3 4218.9 4265.8 4394.9 99321.0 99771.5 100751.0 100995.5 101139.5 78985.0 79739.0 80101.0 80474.6 85257.0 73923.5 74855.3 75063.0 75991.2 76293.6 8067.4 8586.5 8620.2 8644.9 8670.2 33132.0 41170.8 42572.6 42846.9 43742.8 63154.0 65165.4 65955.0 66386.3 66970.3 11006.3 11263.6 11400.4 11435.1 11560.3 11920.3 11993.9 12034.1 12092.0 12912.4 11330.5 11592.7 11774.5 11822.9 11999.8 10036.7 11472.1 11799.4 11883.6 12133.9 11246.9 11723.5 11759.4 11783.7 11810.2 9691.9 9761.3 9806.1 10018.5 10141.3 9290.0 9661.3 9862.6 9966.5 9970.0 06:40:07 INFO - PROCESS | 1662 | -------- Summary: end -------- 06:40:07 INFO - PROCESS | 1662 | 06:40:08 INFO - TEST-INFO | 1662: exit 0 06:40:08 INFO - TEST-OK | dromaeo_css | took 1112824ms 06:40:08 INFO - TEST-START | kraken 06:40:08 INFO - operating with platform_type : mac_ 06:40:08 INFO - Initialising browser for kraken test... 06:40:08 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpBhh4uk/profile http://localhost:49270/getInfo.html) 06:40:10 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 06:40:10 INFO - PROCESS | 1672 | colorDepth:24 06:40:10 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 06:40:10 INFO - PROCESS | 1672 | __metrics 06:40:10 INFO - PROCESS | 1672 | 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" 06:40:10 INFO - PROCESS | 1672 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:40:11 INFO - TEST-INFO | 1672: exit 0 06:40:11 INFO - Browser initialized. 06:40:11 INFO - Running cycle 1/1 for kraken test... 06:40:11 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpBhh4uk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:40:23 INFO - PROCESS | 1674 | RSS: Main: 210976768 06:40:23 INFO - PROCESS | 1674 | 06:40:25 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 06:40:26 INFO - PROCESS | 1674 | RSS: Main: 264855552 06:40:26 INFO - PROCESS | 1674 | 06:40:28 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 06:40:29 INFO - PROCESS | 1674 | RSS: Main: 275451904 06:40:29 INFO - PROCESS | 1674 | 06:40:32 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 06:40:33 INFO - PROCESS | 1674 | RSS: Main: 265670656 06:40:33 INFO - PROCESS | 1674 | 06:40:35 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 06:40:35 INFO - PROCESS | 1674 | RSS: Main: 266964992 06:40:35 INFO - PROCESS | 1674 | 06:40:37 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:40:38 INFO - PROCESS | 1674 | RSS: Main: 266944512 06:40:38 INFO - PROCESS | 1674 | 06:40:41 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 06:40:41 INFO - PROCESS | 1674 | RSS: Main: 266489856 06:40:41 INFO - PROCESS | 1674 | 06:40:44 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 06:40:45 INFO - PROCESS | 1674 | RSS: Main: 268115968 06:40:45 INFO - PROCESS | 1674 | 06:40:47 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 06:40:48 INFO - PROCESS | 1674 | RSS: Main: 267653120 06:40:48 INFO - PROCESS | 1674 | 06:40:49 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:40:50 INFO - PROCESS | 1674 | RSS: Main: 301887488 06:40:50 INFO - PROCESS | 1674 | 06:40:52 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:40:52 INFO - PROCESS | 1674 | RSS: Main: 302514176 06:40:52 INFO - PROCESS | 1674 | 06:40:55 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:40:55 INFO - PROCESS | 1674 | RSS: Main: 308547584 06:40:55 INFO - PROCESS | 1674 | 06:40:58 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:40:58 INFO - PROCESS | 1674 | RSS: Main: 310669312 06:40:58 INFO - PROCESS | 1674 | 06:41:01 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:41:01 INFO - PROCESS | 1674 | RSS: Main: 310415360 06:41:01 INFO - PROCESS | 1674 | 06:41:03 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 06:41:03 INFO - PROCESS | 1674 | RSS: Main: 370749440 06:41:03 INFO - PROCESS | 1674 | 06:41:03 INFO - PROCESS | 1674 | __start_tp_report 06:41:03 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 06:41:03 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 06:41:03 INFO - PROCESS | 1674 | |i|pagename|runs| 06:41:03 INFO - PROCESS | 1674 | |0;ai-astar;111;109;108;109;112;110;118;110;109;109 06:41:03 INFO - PROCESS | 1674 | |1;audio-beat-detection;155;150;183;140;115;137;117;149;147;116 06:41:03 INFO - PROCESS | 1674 | |2;audio-dft;184;184;185;185;184;183;182;183;184;184 06:41:03 INFO - PROCESS | 1674 | |3;audio-fft;72;71;74;114;56;47;50;59;130;82 06:41:03 INFO - PROCESS | 1674 | |4;audio-oscillator;90;97;128;81;105;124;154;75;78;119 06:41:03 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;91;88;90;88;90;86;89;87;90;86 06:41:03 INFO - PROCESS | 1674 | |6;imaging-darkroom;104;122;94;95;94;94;95;96;95;94 06:41:03 INFO - PROCESS | 1674 | |7;imaging-desaturate;85;86;86;84;87;87;85;84;90;86 06:41:03 INFO - PROCESS | 1674 | |8;json-parse-financial;55;59;58;58;55;58;58;68;52;52 06:41:03 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;63;62;70;75;69;68;65;65;65;65 06:41:03 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;80;78;68;97;105;106;105;63;94;108 06:41:03 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;132;136;123;126;126;118;119;131;125;113 06:41:03 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;132;120;131;132;131;120;134;131;133;132 06:41:03 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;64;64;66;65;65;66;65;65;63;64 06:41:03 INFO - PROCESS | 1674 | __end_tp_report 06:41:03 INFO - PROCESS | 1674 | __start_cc_report 06:41:03 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1229 06:41:03 INFO - PROCESS | 1674 | __end_cc_report 06:41:03 INFO - PROCESS | 1674 | __startTimestamp1459345263860__endTimestamp 06:41:03 INFO - PROCESS | 1674 | 06:41:03 INFO - PROCESS | 1674 | ------- Summary: start ------- 06:41:03 INFO - PROCESS | 1674 | Number of tests: 14 06:41:03 INFO - PROCESS | 1674 | 06:41:03 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:110.50 Median:110.00 stddev:2.88 (2.6%) stddev-sans-first:3.05 06:41:03 INFO - PROCESS | 1674 | Values: 111.0 109.0 108.0 109.0 112.0 110.0 118.0 110.0 109.0 109.0 06:41:03 INFO - PROCESS | 1674 | 06:41:03 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:148.00 stddev:21.17 (14.3%) stddev-sans-first:21.83 06:41:03 INFO - PROCESS | 1674 | Values: 155.0 150.0 183.0 140.0 115.0 137.0 117.0 149.0 147.0 116.0 06:41:03 INFO - PROCESS | 1674 | 06:41:03 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:0.92 (0.5%) stddev-sans-first:0.97 06:41:03 INFO - PROCESS | 1674 | Values: 184.0 184.0 185.0 185.0 184.0 183.0 182.0 183.0 184.0 184.0 06:41:03 INFO - PROCESS | 1674 | 06:41:03 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:75.50 Median:65.00 stddev:27.17 (41.8%) stddev-sans-first:28.79 06:41:03 INFO - PROCESS | 1674 | Values: 72.0 71.0 74.0 114.0 56.0 47.0 50.0 59.0 130.0 82.0 06:41:03 INFO - PROCESS | 1674 | 06:41:03 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:76.50 stddev:25.78 (33.7%) stddev-sans-first:26.76 06:41:03 INFO - PROCESS | 1674 | Values: 90.0 97.0 128.0 81.0 105.0 124.0 154.0 75.0 78.0 119.0 06:41:03 INFO - PROCESS | 1674 | 06:41:03 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:89.50 stddev:1.78 (2.0%) stddev-sans-first:1.64 06:41:03 INFO - PROCESS | 1674 | Values: 91.0 88.0 90.0 88.0 90.0 86.0 89.0 87.0 90.0 86.0 06:41:03 INFO - PROCESS | 1674 | 06:41:03 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:98.30 Median:94.50 stddev:8.86 (9.4%) stddev-sans-first:9.15 06:41:03 INFO - PROCESS | 1674 | Values: 104.0 122.0 94.0 95.0 94.0 94.0 95.0 96.0 95.0 94.0 06:41:03 INFO - PROCESS | 1674 | 06:41:03 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.00 stddev:1.76 (2.1%) stddev-sans-first:1.83 06:41:03 INFO - PROCESS | 1674 | Values: 85.0 86.0 86.0 84.0 87.0 87.0 85.0 84.0 90.0 86.0 06:41:03 INFO - PROCESS | 1674 | 06:41:03 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:58.00 stddev:4.55 (7.8%) stddev-sans-first:4.75 06:41:03 INFO - PROCESS | 1674 | Values: 55.0 59.0 58.0 58.0 55.0 58.0 58.0 68.0 52.0 52.0 06:41:03 INFO - PROCESS | 1674 | 06:41:03 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:66.50 stddev:3.86 (5.8%) stddev-sans-first:3.86 06:41:03 INFO - PROCESS | 1674 | Values: 63.0 62.0 70.0 75.0 69.0 68.0 65.0 65.0 65.0 65.0 06:41:03 INFO - PROCESS | 1674 | 06:41:03 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:90.40 Median:73.00 stddev:16.83 (23.1%) stddev-sans-first:17.43 06:41:03 INFO - PROCESS | 1674 | Values: 80.0 78.0 68.0 97.0 105.0 106.0 105.0 63.0 94.0 108.0 06:41:03 INFO - PROCESS | 1674 | 06:41:03 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:126.00 stddev:7.00 (5.6%) stddev-sans-first:6.94 06:41:03 INFO - PROCESS | 1674 | Values: 132.0 136.0 123.0 126.0 126.0 118.0 119.0 131.0 125.0 113.0 06:41:03 INFO - PROCESS | 1674 | 06:41:03 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:129.60 Median:132.00 stddev:5.15 (3.9%) stddev-sans-first:5.39 06:41:03 INFO - PROCESS | 1674 | Values: 132.0 120.0 131.0 132.0 131.0 120.0 134.0 131.0 133.0 132.0 06:41:03 INFO - PROCESS | 1674 | 06:41:03 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:0.95 (1.5%) stddev-sans-first:0.97 06:41:03 INFO - PROCESS | 1674 | Values: 64.0 64.0 66.0 65.0 65.0 66.0 65.0 65.0 63.0 64.0 06:41:03 INFO - PROCESS | 1674 | -------- Summary: end -------- 06:41:03 INFO - PROCESS | 1674 | 06:41:04 INFO - TEST-INFO | 1674: exit 0 06:41:04 INFO - TEST-OK | kraken | took 56174ms 06:41:04 INFO - SUITE-END | took 1168s 06:41:05 INFO - Completed test suite (00:19:29) 06:41:05 INFO - javascript benchmark 06:41:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3376.645452227516, 3506.4389697648367, 3523.0663874073366, 3528.841202145903, 3568.482570027346, 5238.109521381365, 5738.684372359518, 5748.511376533, 5756.7409466574, 5780.8265752027455, 5747.33905600855, 5797.333306669734, 5805.593608447411, 5806.071028635419, 5806.44838740319, 5193.1171700810955, 5208.5051920067535, 5212.400573933989, 5264.052470555299, 5314.813981510648, 5335.946640533583, 5336.252924590561, 5336.519713225809, 5343.839684809462, 5347.25138480613, 5253.816116435925, 5312.256284120226, 5314.627976041678, 5342.171963345668, 5345.732713364336, 4618.5682438443855, 5322.281491998569, 5356.54469370104, 5364.356277246756, 5377.704226267573, 5048.974755126201, 5200.973995130038, 5223.947760522422, 5247.291615631879, 5288.23320618512, 5684.062129748587, 5722.341930677983, 5727.713614319267, 5737.2254745609225, 5752.913706294409, 6269.216347956505, 6354.3010268870385, 6354.650494222862, 6356.777512787076, 6358.618482891041, 6267.59260648061, 6314.0, 6349.36506349366, 6367.681615919186, 6388.2334119905445, 5944.375840536768, 5968.045112782021, 5980.55145864062, 5983.611065280743, 5991.071383935497, 5865.912011319749, 6364.363563643598, 6377.266614339317, 6381.489480841522, 6383.106365108889, 6169.876602467925, 6176.752929882844, 6306.779262725782, 6313.084602732578, 6314.747410103544, 6365.522585806083, 6365.61806291624, 6374.776882809079, 6381.521385896076, 6404.263509696351, 6114.206128133723, 6287.025511045796, 6313.621182729051, 6368.936310636835, 6378.45783108441, 6188.535859810532, 6302.023186406022, 6334.3032266450655, 6342.809715708536, 6351.682415879188, 4128.587141285908, 4942.950570494249, 4957.231629097496, 4963.61410040719, 4976.0, 4451.376807246988, 4481.282994720894, 4509.368688383629, 4519.322101684708, 4559.54404559548, 5738.053221218535, 5779.88440231193, 5801.100829371454, 5833.649981001068, 5842.5618078644275, 6261.9605036210305, 6311.842203944846, 6329.90505142414, 6347.1114044033875, 6347.841303967438, 5610.354809196913, 5730.942690573041, 5777.62445441045, 5795.565332599987, 5832.154337621021, 5401.432849550819, 5448.863778405493, 5454.672719636835, 5475.06923822951, 5494.972525137348, 6320.589161704658, 6340.8414789629705, 6367.4906007519285, 6379.425851673279, 6386.393292637378, 6251.0, 6251.281102673069, 6350.618962862243, 6354.332795056453, 6362.331955144643, 6312.652804095819, 6365.108884756045, 6381.904271436025, 6383.8084857452495, 6396.0, 6273.466755325849, 6325.1144839721555, 6367.968160159169, 6374.58565193261, 6382.393672601282, 6232.09634602971, 6257.4681152102585, 6261.123442718114, 6353.5870168438905, 6364.554481186273, 6071.908921366095, 6136.203000408158, 6164.260288765377, 6170.413810687977, 6176.752929882754, 6127.632342059491, 6141.560725993458, 6146.0473626587955, 6163.0, 6164.260288765377, 5910.172575839472, 5990.191324171181, 6018.608790428608, 6025.78909738157, 6048.455638992512, 6195.969020155051, 6197.566170368031, 6203.2245969253845, 6218.098375735583, 6222.346653601307, 6086.908696369469, 6107.358727333566, 6112.358202388685, 6120.632762034292, 6123.357047509948], "unit": "score", "name": "dojo.html", "value": 5777.402733199801}, {"lowerIsBetter": false, "replicates": [495.36593160754245, 590.4508806809665, 596.0, 658.6015460646311, 659.7427003468647, 39908.40137397938, 40809.3878591821, 40850.7957460213, 40860.79569602155, 40868.386974195375, 39429.014274643145, 43955.78022109893, 44791.552084479146, 44857.7757111214, 44886.55113448865, 9292.210162136227, 9904.059114384121, 9916.652917147901, 9920.355176913514, 9921.603135874557, 8678.739637810875, 9377.437353758762, 9529.80940381192, 9814.754631134243, 9821.558029888673, 9785.07041831025, 9842.458664773434, 9847.507624618776, 9857.457839818808, 9876.703698889009, 9762.121409073183, 9792.951035244778, 9815.214782817393, 9819.312648114636, 9821.459819709913, 9813.067758562926, 9933.106020458194, 9949.10458058771, 9951.20390368776, 9979.451130187837, 43537.56462435367, 43739.34390984138, 43744.0, 43815.34276985848, 43858.0, 3209.2297848516423, 3210.4542227821325, 3242.9351412971846, 3256.8371581420834, 3808.5239345081864, 29709.757523370678, 30115.397692046256, 30198.0, 30396.392072158655, 30632.54051189234, 2798.8460634665084, 2815.6480439945008, 2834.362268489594, 2869.253993961564, 2902.3034471726846, 483143.16856831335, 484108.0, 484499.0, 484656.0, 485885.0, 72384.63807680928, 72662.63668681623, 72823.90764138542, 72833.6358318205, 72879.90680139803, 77271.0, 77589.61205193937, 80034.79947800787, 80228.0, 80744.0, 16475.505734827733, 18628.441146765617, 18841.528961776065, 18852.680312378277, 18862.15120319589, 14112.50606228777, 14188.64528386778, 14205.857941420454, 14229.715405691828, 14239.0, 18917.527061823566, 19085.61828763417, 19668.21327146898, 23056.654150187762, 23754.812259386963, 7495.925040749632, 9227.492487913229, 9434.716958491255, 9440.395601327988, 9447.149756521945, 967.1972263021676, 997.3168379659957, 1037.9325343852624, 1056.5087234436023, 1092.710940070394, 30117.09648710542, 30481.933132340262, 30563.38873222523, 30884.91902783392, 31243.68756312453, 1129.412705393191, 1166.5567084508002, 1171.701216189866, 1201.387292480841, 1234.1299383934304, 15498.690026199638, 15681.451149209723, 15831.050136991817, 15928.642534160716, 15997.60005999836, 552072.0, 555868.0, 557925.0, 558968.0, 559112.0, 63092.68453657702, 63606.0, 63921.36078639247, 64168.67915660392, 64294.35705642977, 1405.3394904394918, 1422.8648278413534, 1540.3376548084207, 1557.4548907882377, 1657.2790835986384, 28223.012194573912, 28763.5685464714, 29618.111456656334, 31215.0, 31423.37153256968, 54592.454075458736, 55183.44816551783, 55593.722031391204, 55647.0, 55665.0, 377189.0, 381411.0, 381675.0, 381870.0, 383757.0, 29933.70066299309, 34107.48838767371, 48531.27203092027, 48730.26904596363, 49041.26438103503, 47085.0, 47868.76065619649, 47906.04187916292, 48057.0, 48106.0, 38512.03719907025, 38548.80725596354, 38887.0, 39022.63420780259, 39828.60171398249, 37868.810655947644, 38177.42733858939, 38851.417228741026, 38872.41691374575, 38888.611113888495, 39820.08875754372, 40137.799311003255, 41411.0, 41418.96452588589, 41423.0, 33157.0, 36393.256411789494, 36833.81583092068, 38025.80987095047, 38383.04042398962, 26846.597301040892, 27186.72813271842, 27192.456150876475, 27230.72769272282, 27390.5891411633], "unit": "score", "name": "ext.html", "value": 20999.194493793348}, {"lowerIsBetter": false, "replicates": [320.6969413903861, 366.6974745834687, 376.4065588098005, 379.71521358980766, 381.9350710379239, 19870.90710010949, 20435.284765033226, 21117.260895868647, 21914.561708765814, 21942.23202187922, 21332.680009799828, 21387.144514219413, 21686.24098156565, 21687.02408391626, 21757.238496652582, 5707.258056452666, 5980.79067232647, 6023.638581685091, 6027.5479339049525, 6031.819045428622, 3909.530856297248, 4089.4683691120113, 5549.6115271930985, 7282.854342913139, 7648.311651951323, 7267.0, 7632.542047477142, 7636.045494313211, 7644.885326720076, 7655.732049378273, 7477.700891964315, 7495.325420712162, 7546.056742907137, 7554.169041405414, 7557.206493318205, 4519.07358991406, 6923.376896079377, 7209.567425954459, 7221.350078492961, 7228.963855180743, 27705.44589108227, 28638.570421443696, 29051.56422653662, 29363.119106426842, 29491.820327186888, 2550.846949183055, 2738.178546436081, 2868.6127372804613, 3185.1718553176343, 3212.084555901557, 15523.301451434712, 15604.60988475286, 15789.526314210592, 16132.0, 16473.67052658952, 1871.429214089702, 1944.212593899473, 1959.304446921351, 2012.0442789674787, 2055.856090073695, 115980.0, 127249.0, 128012.35993820065, 128382.0, 131149.6885031147, 20569.074391652113, 20732.067056982472, 20826.1669533217, 20958.16167353319, 21016.894915525325, 30681.079567613007, 30785.38429231403, 31391.21521961969, 31413.685863141076, 31419.371612567622, 9854.669619601405, 11224.270422422516, 11512.136589755803, 11539.307641541534, 11774.705632359088, 9824.361416507903, 9838.212942964547, 9840.753981150528, 9879.407235565888, 9947.55236014381, 9203.677871274607, 9257.907420925705, 9347.719568412958, 9385.5307234638, 9411.811763764686, 3013.412384584985, 3239.0121013091234, 3309.652486488932, 3535.1338921964284, 3664.120611053328, 411.29668267263315, 413.3469118792301, 432.5285438871645, 786.8072322281078, 952.476138124029, 11692.0, 12016.0, 12064.457099430547, 12092.455839487244, 12155.5137794489, 457.9564941330635, 458.55291091185825, 461.89145550795536, 463.1408736793267, 474.29803890242636, 6132.202813634199, 6222.12890195373, 6222.751089956441, 6273.435390814849, 6314.336994615591, 674253.0, 685307.0, 686538.0, 694397.0, 703100.1399160463, 127788.0, 129167.0, 129959.0, 131424.0, 132567.33716331355, 459.0612198054986, 460.61768731953066, 463.27960022165183, 464.5169024214779, 464.94420669519195, 9182.0, 10705.411202383944, 11176.10591152722, 11207.327560346404, 11302.886971130183, 51288.74355628198, 51973.22040169476, 52218.0, 52689.47310526999, 53004.73497632487, 76685.84971225324, 78263.0, 82093.0, 84777.0, 85908.71136932826, 7087.149542054986, 8077.313428358655, 8148.185181482041, 8219.383546234176, 8336.0, 9170.403923744936, 11384.544618215179, 12063.939680301894, 12740.745185096432, 13278.734425311633, 11269.830952535554, 11348.489317980875, 11350.829737554108, 11356.034737047443, 11364.94317528407, 11220.046296064926, 11253.0, 11376.601818936297, 11441.771164576829, 11704.419903313285, 10895.891041089488, 11602.18784685064, 11897.643070707893, 11904.821427678418, 12115.81826272589, 8035.67857285702, 8111.594420278844, 8251.95874020626, 8275.83448331042, 8480.74557763268, 11901.523939042687, 11973.880261197277, 12064.396780161132, 12117.878821211674, 12221.69445763863], "unit": "score", "name": "jquery.html", "value": 9962.39128557893}, {"lowerIsBetter": false, "replicates": [1496.4163976049335, 1615.6203292226326, 1645.4981230724627, 1948.6102779444107, 2046.0153650958564, 8225.218604232596, 8826.823463530734, 8999.685011024616, 9003.324750643695, 9010.369274150811, 8813.294936405087, 9060.365774395796, 9084.909150908505, 9095.135962083592, 9095.54522273887, 2253.256425379621, 2508.5233805576927, 2520.6975162980466, 2535.5816290312077, 2554.6551215585937, 2164.7618761936174, 2564.0, 2567.281161274846, 2567.8074144439147, 2569.02377096703, 2508.686414198225, 2568.8073394495395, 2589.4173810892494, 2589.7669209771116, 2591.1449221756775, 2200.7249093863265, 2487.6641653376832, 2569.730178331267, 2575.9227223183148, 2576.059738195564, 2542.6313184588316, 2560.667113275281, 2572.4340645058055, 2580.909668161605, 2591.119019533349, 9115.088491150831, 9219.723408297761, 9221.907780922173, 9224.631014759469, 9248.722538323862, 5517.44825517449, 5663.773449062032, 5697.515711164556, 5702.173184888209, 5733.741981610796, 3643.234920666663, 3714.832832522516, 3822.197338558906, 3822.4075268333454, 3822.9235415291537, 1044.952977116024, 1075.4353964168795, 1081.2107161771871, 1095.9287646302964, 1117.0951529261242, 10546.05085542305, 10681.824999250077, 12360.876391236152, 12477.190807332976, 12518.311492867888, 5036.924446133311, 5044.520770526794, 5114.667546609458, 5121.308623335802, 5160.148575485078, 10499.0, 10544.578216871392, 10550.050495455293, 10558.577656893793, 10558.736031599117, 5662.037453632893, 5676.403977582377, 5682.460166284196, 5690.260266165455, 5691.943080569141, 4584.15193189261, 4768.0702263059065, 4862.222044472938, 4914.238293064581, 4921.9507804922205, 4044.295597330519, 4085.7752823594988, 4139.19285739284, 4181.456410666594, 4184.895377615584, 1316.1559888579234, 1345.5156143788424, 1350.216874212954, 1353.9932300338633, 1358.0697222402687, 1173.5975509266516, 1192.4157162990073, 1201.8497687789027, 1390.513320337894, 1426.12293439536, 8377.287930525974, 8390.0, 8435.325173986066, 8438.493690378597, 8488.533130677872, 507.9187330027178, 523.4843678976206, 525.6373102559222, 525.8343621759134, 527.7123967437756, 6301.149344838388, 6349.428551430301, 6390.7763228286785, 6395.904061439082, 6404.42360187576, 10597.470126493645, 11050.889491104987, 11063.446827658585, 11089.500972456259, 11095.001449869389, 10414.583416663248, 10818.026377625894, 10883.78232435347, 10890.019898209199, 10935.507902144423, 8412.158784121539, 8450.661973521113, 8606.26846718036, 8613.741587752378, 8652.394332396672, 8042.235987581171, 8167.591620418836, 8194.631241594023, 8209.220124088202, 8250.711225107092, 9282.953585232031, 9568.330216884751, 9570.808583828146, 9733.124018838338, 9740.0, 9670.0, 9970.700878973643, 10052.045055719695, 10151.187904967732, 10181.981801819758, 7486.850262994601, 7681.308682218627, 7710.961445192738, 7719.691212351443, 7797.0, 8495.150484951455, 8509.978802543734, 8559.400841941004, 8578.313734901069, 8581.399302048796, 7426.777196683892, 7587.734429295169, 7651.923480765121, 7658.578778167254, 7661.425393095428, 7393.260673932778, 7439.181690014202, 7489.176190618919, 7519.248075192437, 7582.62086895642, 7987.92012079895, 8018.799530011796, 8033.758987230392, 8051.677932882853, 8066.637001334837, 7196.172440169447, 7197.280271972971, 7222.96388518054, 7278.199398066315, 7291.489595728461, 7360.0, 7379.0, 7415.0, 7426.962865185639, 7434.3309102181065], "unit": "score", "name": "mootools.html", "value": 4984.620821203869}, {"lowerIsBetter": false, "replicates": [329.0769391855844, 335.3845693153064, 336.56919143496316, 338.06356392791974, 341.5969156395454, 6666.766663166784, 6677.465802735769, 6713.7985860424205, 6736.427403670687, 6741.123653924995, 5348.893022139555, 6652.467802575795, 6660.9666951665295, 6667.366600172976, 6673.09913161723, 4733.100710864925, 4805.7597120143855, 4908.631852611051, 4919.754012299389, 4956.702597844141, 4890.926636100461, 4900.289458028584, 4918.631102667297, 4928.383952005999, 4957.925631115536, 4881.145799485093, 4891.241857512091, 4897.628663974093, 4915.361003069596, 4925.630577706668, 4659.906801863961, 4768.737719425448, 4892.584130348924, 4911.263310503417, 4922.556969872693, 4232.365145228209, 4236.51280102789, 4236.555161708007, 4243.448351714257, 4253.319468884994, 6326.335734747831, 6373.904391434132, 6382.776602818925, 6389.137466442017, 6430.58201216924, 5839.474447299721, 5843.298804143487, 5845.123231515264, 5853.356130825606, 5858.179854820329, 6732.1921369435495, 7068.752593659197, 7077.009218709385, 7082.804330657461, 7084.291570842926, 4567.880869187071, 4588.816447342136, 4612.238980568202, 4634.814607415733, 4638.281066434708, 7297.722898492796, 7376.336129748348, 7466.738664146783, 7471.364933980618, 7480.326770590673, 3954.62431069048, 4674.205385084544, 4688.507706690816, 4691.81232750693, 4703.835365762182, 4725.64557658177, 4735.431748190239, 4735.810567577328, 4738.147133516, 4747.098051370229, 5629.774809007594, 5655.1799989001365, 5662.886742265132, 5674.404187560329, 5675.829725108253, 6838.384545390939, 7045.084139061889, 7099.787006389816, 7150.678219480136, 7152.678129484186, 1596.1859451679727, 1628.51958672192, 1631.5350125214495, 1634.1910754176758, 1635.8364163583785, 984.0356450678375, 1018.9133923616575, 1046.1108058150512, 1046.7173863056933, 1073.098597178374, 6240.812775616739, 6259.186305780219, 6271.62370257786, 6272.2159730033745, 6352.968235158794, 7268.400951790598, 7282.96358518204, 7286.453515986323, 7308.890366644505, 7332.486725929134, 6483.837904052342, 6517.869642607121, 6521.934780652227, 6529.955207166926, 6534.640594767334, 3846.8845934622004, 3894.045958740127, 3897.279003384383, 3899.590542992945, 3900.531936167621, 7352.19125896151, 7635.618219089023, 7723.459357845009, 7743.341815945595, 7747.147813740484, 7548.471606987568, 7628.69485220596, 7634.770956871303, 7637.19809420014, 7637.770866874002, 7688.923550702906, 7694.153643099255, 7697.4226932980255, 7708.884366734504, 7716.922830771845, 7101.183363913009, 7342.559446433231, 7383.114026316876, 7411.814704632212, 7417.592032438268, 7193.964030179815, 7236.782896513113, 7239.565626062453, 7260.16508101554, 7279.199288078201, 7648.388128949559, 7670.386369090571, 7673.0, 7675.961620191863, 7676.117246516722, 4595.701279416827, 4645.721256724607, 4649.814007439664, 4654.138984287918, 4658.0218154188, 7106.609136497335, 7310.305520975498, 7327.596982166032, 7329.52358096722, 7340.779776606711, 7035.788926332219, 7095.751648692271, 7116.893246601202, 7120.1099862517185, 7128.394086502705, 7065.0815393998455, 7074.903389974562, 7077.752278670222, 7080.893786593102, 7093.893591596027, 6921.861562768616, 6933.0, 6935.7225710971, 6938.167419909643, 6950.895736564057, 6796.72813087471, 7079.398251148504, 7087.184973727881, 7096.822579435556, 7108.502404831819, 6636.13730215069, 6826.761063362758, 6884.621345826027, 6901.0, 6964.582125072512], "unit": "score", "name": "prototype.html", "value": 5185.316485080574}, {"lowerIsBetter": false, "replicates": [709.9254578269282, 762.249184553215, 767.6392095715012, 776.4332037612543, 778.8442311537694, 12117.272963622188, 15177.317020734066, 15216.467423640175, 15217.695646087072, 15228.92385538072, 14385.64035899103, 14421.78367324491, 14455.132692038485, 14461.78307325391, 14475.565733028026, 776.3827756933251, 779.7543773711291, 927.638221093774, 931.7670582354411, 949.9192568631657, 919.56320747645, 924.0251534630962, 924.089771574998, 925.6019911438079, 945.3524335829944, 976.9804603907918, 992.6128809764198, 996.4419924842075, 999.8900120986685, 1016.7153197104823, 814.4868732698362, 819.5246756880995, 976.9853452198187, 981.8919918808925, 1007.8085163818888, 744.9664765085585, 750.8761054426013, 752.8268498245434, 753.4311594745986, 755.0674916478146, 15548.455804046916, 15635.983661061995, 15642.2178891055, 15644.921775391163, 15652.68694626101, 10938.234323597351, 13278.0, 13411.329433528383, 13651.180929144184, 13679.931600341935, 8576.614052367659, 10308.381497110197, 10326.535305911251, 10453.372797632166, 10585.259031867772, 3542.8405721742324, 3562.5012498250267, 3682.355587772129, 3751.306008388457, 3812.4471951567143, 82377.0, 82675.5866220671, 84804.0, 85051.0, 85101.14898851055, 8926.776830579158, 9042.683506077256, 9191.218746406497, 9418.152366287068, 9570.95214523923, 21328.466788330104, 21389.78610213878, 21435.821029843195, 21487.46281342979, 21514.0, 7568.659410326549, 7605.923940760632, 7649.04386951631, 7674.117476490275, 7731.420143489261, 3800.726756536536, 4210.305299625527, 4243.766592837362, 4249.766262855511, 4297.355396690521, 3706.9073273168387, 3811.2377524495214, 3819.1788765415567, 3819.6371344722206, 3821.102041020358, 664.9434798042221, 668.3383450384084, 670.7752902777527, 677.1738479055545, 687.8521117959663, 506.20020367818756, 530.4165418040125, 540.8755986123214, 580.2398857496693, 636.4717284653726, 7902.723404680809, 8317.20986506293, 8450.323974082059, 8473.384817106316, 8520.8721869172, 523.2517499975072, 603.5111559636621, 606.9878602427926, 613.0191693290699, 624.2883113250898, 3766.642168993941, 4042.312806822847, 4218.936715949263, 4265.765382903908, 4394.890127746768, 99321.0, 99771.50114249383, 100751.0, 100995.49502252441, 101139.49430252802, 78985.0, 79739.0, 80101.0, 80474.59762701149, 85257.0, 73923.5215295691, 74855.25144748592, 75062.99999999891, 75991.24008759842, 76293.6185319081, 8067.435279530377, 8586.484810911365, 8620.181082797124, 8644.870326944974, 8670.2212318956, 33132.0, 41170.794146029075, 42572.5742742581, 42846.92882677958, 43742.781286094636, 63154.0, 65165.370865728735, 65955.01067484087, 66386.33613663995, 66970.33029669641, 11006.339619622848, 11263.605773797877, 11400.429978501208, 11435.085193184692, 11560.30638161713, 11920.284782913053, 11993.880061199276, 12034.097442691658, 12092.0, 12912.354382281037, 11330.490127944428, 11592.710182245512, 11774.470148843151, 11822.940885295518, 11999.82000270014, 10036.749081273027, 11472.082233421474, 11799.410029498662, 11883.584074557695, 12133.939330303292, 11246.887531124585, 11723.531058757555, 11759.353235572125, 11783.705407364885, 11810.173287869766, 9691.9030809691, 9761.316707830383, 9806.068423499755, 10018.499075046073, 10141.340812847142, 9290.0, 9661.3237073407, 9862.630827783143, 9966.451845148586, 9970.03135791687], "unit": "score", "name": "yui.html", "value": 7025.342294232163}], "name": "dromaeo_css", "value": 7766.6737958286885}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 108.0, 109.0, 112.0, 110.0, 118.0, 110.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [155.0, 150.0, 183.0, 140.0, 115.0, 137.0, 117.0, 149.0, 147.0, 116.0], "unit": "score", "name": "audio-beat-detection", "value": 140.9}, {"lowerIsBetter": true, "replicates": [184.0, 184.0, 185.0, 185.0, 184.0, 183.0, 182.0, 183.0, 184.0, 184.0], "unit": "score", "name": "audio-dft", "value": 183.8}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 74.0, 114.0, 56.0, 47.0, 50.0, 59.0, 130.0, 82.0], "unit": "score", "name": "audio-fft", "value": 75.5}, {"lowerIsBetter": true, "replicates": [90.0, 97.0, 128.0, 81.0, 105.0, 124.0, 154.0, 75.0, 78.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 105.1}, {"lowerIsBetter": true, "replicates": [91.0, 88.0, 90.0, 88.0, 90.0, 86.0, 89.0, 87.0, 90.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.5}, {"lowerIsBetter": true, "replicates": [104.0, 122.0, 94.0, 95.0, 94.0, 94.0, 95.0, 96.0, 95.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 98.3}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 86.0, 84.0, 87.0, 87.0, 85.0, 84.0, 90.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 86.0}, {"lowerIsBetter": true, "replicates": [55.0, 59.0, 58.0, 58.0, 55.0, 58.0, 58.0, 68.0, 52.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 70.0, 75.0, 69.0, 68.0, 65.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.7}, {"lowerIsBetter": true, "replicates": [80.0, 78.0, 68.0, 97.0, 105.0, 106.0, 105.0, 63.0, 94.0, 108.0], "unit": "score", "name": "stanford-crypto-aes", "value": 90.4}, {"lowerIsBetter": true, "replicates": [132.0, 136.0, 123.0, 126.0, 126.0, 118.0, 119.0, 131.0, 125.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.9}, {"lowerIsBetter": true, "replicates": [132.0, 120.0, 131.0, 132.0, 131.0, 120.0, 134.0, 131.0, 133.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 129.6}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 63.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.7}], "name": "kraken", "value": 1422.2}]} 06:41:05 INFO - Return code: 0 06:41:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:41:05 INFO - # TBPL SUCCESS # 06:41:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:41:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:41:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:41:05 INFO - 2016-03-30 06:41:05.200 screenresolution[1678:10067] starting screenresolution argv=screenresolution get 06:41:05 INFO - 2016-03-30 06:41:05.202 screenresolution[1678:10067] Display 0: 1600x1200x32@60 06:41:05 INFO - 2016-03-30 06:41:05.208 screenresolution[1679:10070] starting screenresolution argv=screenresolution list 06:41:05 INFO - Available Modes on Display 0 06:41:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:41:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:41:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:41:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:41:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:41:05 INFO - Intel Iris: 06:41:05 INFO - Chipset Model: Intel Iris 06:41:05 INFO - Type: GPU 06:41:05 INFO - Bus: Built-In 06:41:05 INFO - VRAM (Dynamic, Max): 1536 MB 06:41:05 INFO - Vendor: Intel (0x8086) 06:41:05 INFO - Device ID: 0x0a2e 06:41:05 INFO - Revision ID: 0x0009 06:41:05 INFO - Displays: 06:41:05 INFO - Display: 06:41:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:41:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:41:05 INFO - Display Serial Number: 1600x1200 60 06:41:05 INFO - Main Display: Yes 06:41:05 INFO - Mirror: Off 06:41:05 INFO - Online: Yes 06:41:05 INFO - Rotation: Supported 06:41:05 INFO - Return code: 0 06:41:05 INFO - Running post-action listener: _resource_record_post_action 06:41:05 INFO - Running post-run listener: _resource_record_post_run 06:41:06 INFO - Total resource usage - Wall time: 1203s; CPU: 52.0%; Read bytes: 37434880; Write bytes: 664026112; Read time: 391; Write time: 1960 06:41:06 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 356155904; Write bytes: 353765376; Read time: 28076; Write time: 690 06:41:06 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 35644928; Write bytes: 299086848; Read time: 373; Write time: 1235 06:41:06 INFO - Running post-run listener: _upload_blobber_files 06:41:06 INFO - Blob upload gear active. 06:41:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:41:06 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 06:41:06 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'] 06:41:06 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 06:41:07 INFO - (blobuploader) - INFO - Open directory for files ... 06:41:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:41:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:41:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:41:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:41:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:41:09 INFO - (blobuploader) - INFO - Done attempting. 06:41:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:41:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:41:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:41:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:41:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:41:11 INFO - (blobuploader) - INFO - Done attempting. 06:41:11 INFO - (blobuploader) - INFO - Iteration through files over. 06:41:11 INFO - Return code: 0 06:41:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:41:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:41:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d69ff7e2a5b507fb72737a034967c53264121cc979773ef0074c90e01b5177e7ef9b651af8c713e427775cdbd434e508fda7a399775092037c57453b5db6d442", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e36faf6ead38f81a69d86ffebf7ceb2e83cbb44c8eb695f4200fd8621a0fb18d87d6885683c66a1964fd72214a979eb377d1c415041e7bd613f66f97d0f10725"} 06:41:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:41:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:41:11 INFO - Contents: 06:41:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d69ff7e2a5b507fb72737a034967c53264121cc979773ef0074c90e01b5177e7ef9b651af8c713e427775cdbd434e508fda7a399775092037c57453b5db6d442", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e36faf6ead38f81a69d86ffebf7ceb2e83cbb44c8eb695f4200fd8621a0fb18d87d6885683c66a1964fd72214a979eb377d1c415041e7bd613f66f97d0f10725"} 06:41:11 INFO - Running post-run listener: copy_logs_to_upload_dir 06:41:11 INFO - Copying logs to upload dir... 06:41:11 INFO - mkdir: /builds/slave/test/build/upload/logs 06:41:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.911128 ========= master_lag: 0.74 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-03-30 06:41:12.740796) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-30 06:41:12.746378) ========= 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.0Fw3JhsLok/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.nUMn6qpQ5v/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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/d69ff7e2a5b507fb72737a034967c53264121cc979773ef0074c90e01b5177e7ef9b651af8c713e427775cdbd434e508fda7a399775092037c57453b5db6d442", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e36faf6ead38f81a69d86ffebf7ceb2e83cbb44c8eb695f4200fd8621a0fb18d87d6885683c66a1964fd72214a979eb377d1c415041e7bd613f66f97d0f10725"} build_url:https://queue.taskcluster.net/v1/task/THTHp_rfStu6IcFyl4nKcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011085 build_url: 'https://queue.taskcluster.net/v1/task/THTHp_rfStu6IcFyl4nKcg/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/d69ff7e2a5b507fb72737a034967c53264121cc979773ef0074c90e01b5177e7ef9b651af8c713e427775cdbd434e508fda7a399775092037c57453b5db6d442", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e36faf6ead38f81a69d86ffebf7ceb2e83cbb44c8eb695f4200fd8621a0fb18d87d6885683c66a1964fd72214a979eb377d1c415041e7bd613f66f97d0f10725"}' ========= master_lag: 0.20 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-30 06:41:12.953784) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-03-30 06:41:12.954118) ========= 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.0Fw3JhsLok/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.nUMn6qpQ5v/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.005042 ========= master_lag: 5.63 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-03-30 06:41:18.586932) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-30 06:41:18.587221) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-30 06:41:18.977356) ========= ========= Total master_lag: 7.45 =========