builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0098 starttime: 1458380699.0 results: success (0) buildid: 20160319004052 builduid: 8397bc14f3f844e6a4f27c6548e15089 revision: 6d030cb1d2ab43b99cc2b5b585d9acbdf6fc9e35 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-19 02:44:58.999172) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-19 02:44:58.999626) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-19 02:44:58.999932) ========= 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.9yMun4gGIB/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.ynVyBprsik/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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.005908 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-19 02:44:59.054869) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-19 02:44:59.055174) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-19 02:44:59.212348) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 02:44:59.212824) ========= 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.9yMun4gGIB/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.ynVyBprsik/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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.005428 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 02:44:59.294233) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-19 02:44:59.294526) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-19 02:44:59.294928) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 02:44:59.295230) ========= 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.9yMun4gGIB/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.ynVyBprsik/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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-19 02:44:59-- 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% 49.9M=0s 2016-03-19 02:44:59 (49.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136407 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 02:44:59.462219) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 02:44:59.462850) ========= 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.9yMun4gGIB/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.ynVyBprsik/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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.025417 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 02:44:59.531091) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-19 02:44:59.531392) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6d030cb1d2ab43b99cc2b5b585d9acbdf6fc9e35 --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 6d030cb1d2ab43b99cc2b5b585d9acbdf6fc9e35 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9yMun4gGIB/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.ynVyBprsik/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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-19 02:44:59,606 truncating revision to first 12 chars 2016-03-19 02:44:59,606 Setting DEBUG logging. 2016-03-19 02:44:59,606 attempt 1/10 2016-03-19 02:44:59,606 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6d030cb1d2ab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-19 02:45:00,691 unpacking tar archive at: mozilla-aurora-6d030cb1d2ab/testing/mozharness/ program finished with exit code 0 elapsedTime=1.336232 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-19 02:45:00.884854) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-19 02:45:00.885187) ========= echo 6d030cb1d2ab43b99cc2b5b585d9acbdf6fc9e35 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6d030cb1d2ab43b99cc2b5b585d9acbdf6fc9e35'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9yMun4gGIB/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.ynVyBprsik/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 6d030cb1d2ab43b99cc2b5b585d9acbdf6fc9e35 program finished with exit code 0 elapsedTime=0.005595 script_repo_revision: '6d030cb1d2ab43b99cc2b5b585d9acbdf6fc9e35' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-19 02:45:00.933993) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-19 02:45:00.934264) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-19 02:45:00.948334) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-03-19 02:45:00.949004) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.9yMun4gGIB/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.ynVyBprsik/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 02:45:01 INFO - MultiFileLogger online at 20160319 02:45:01 in /builds/slave/test 02:45:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:45:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:45:01 INFO - {'append_to_log': False, 02:45:01 INFO - 'base_work_dir': '/builds/slave/test', 02:45:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:45:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:45:01 INFO - 'branch': 'Mozilla-Aurora', 02:45:01 INFO - 'buildbot_json_path': 'buildprops.json', 02:45:01 INFO - 'config_files': ('talos/mac_config.py',), 02:45:01 INFO - 'default_actions': ('clobber', 02:45:01 INFO - 'read-buildbot-config', 02:45:01 INFO - 'download-and-extract', 02:45:01 INFO - 'populate-webroot', 02:45:01 INFO - 'create-virtualenv', 02:45:01 INFO - 'install', 02:45:01 INFO - 'run-tests'), 02:45:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:45:01 INFO - 'download_minidump_stackwalk': True, 02:45:01 INFO - 'download_symbols': 'ondemand', 02:45:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:45:01 INFO - 'tooltool.py': '/tools/tooltool.py', 02:45:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:45:01 INFO - '/tools/misc-python/virtualenv.py')}, 02:45:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:45:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:45:01 INFO - 'installer_path': 'installer.exe', 02:45:01 INFO - 'log_level': 'info', 02:45:01 INFO - 'log_name': 'talos', 02:45:01 INFO - 'log_to_console': True, 02:45:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:45:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:45:01 INFO - 'opt_config_files': (), 02:45:01 INFO - 'pip_index': False, 02:45:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:45:01 INFO - 'cmd': ('bash', 02:45:01 INFO - '-c', 02:45:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:45:01 INFO - 'enabled': True, 02:45:01 INFO - 'halt_on_failure': False, 02:45:01 INFO - 'name': 'check_screen_resolution'},), 02:45:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:45:01 INFO - 'cmd': ('bash', 02:45:01 INFO - '-c', 02:45:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:45:01 INFO - 'enabled': True, 02:45:01 INFO - 'halt_on_failure': False, 02:45:01 INFO - 'name': 'check_screen_resolution'},), 02:45:01 INFO - 'run_cmd_checks_enabled': True, 02:45:01 INFO - 'sps_profile': False, 02:45:01 INFO - 'sps_profile_interval': 0, 02:45:01 INFO - 'suite': 'dromaeojs-e10s', 02:45:01 INFO - 'system_bits': '32', 02:45:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:45:01 INFO - 'title': 't-yosemite-r7-0098', 02:45:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:45:01 INFO - 'use_talos_json': True, 02:45:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:45:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:45:01 INFO - 'work_dir': 'build'} 02:45:01 INFO - ##### 02:45:01 INFO - ##### Running clobber step. 02:45:01 INFO - ##### 02:45:01 INFO - Running pre-action listener: _resource_record_pre_action 02:45:01 INFO - Running main action method: clobber 02:45:01 INFO - rmtree: /builds/slave/test/build 02:45:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:45:02 INFO - Running post-action listener: _resource_record_post_action 02:45:02 INFO - ##### 02:45:02 INFO - ##### Running read-buildbot-config step. 02:45:02 INFO - ##### 02:45:02 INFO - Running pre-action listener: _resource_record_pre_action 02:45:02 INFO - Running main action method: read_buildbot_config 02:45:02 INFO - Using buildbot properties: 02:45:02 INFO - { 02:45:02 INFO - "project": "", 02:45:02 INFO - "product": "firefox", 02:45:02 INFO - "script_repo_revision": "production", 02:45:02 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:45:02 INFO - "repository": "", 02:45:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:45:02 INFO - "buildid": "20160319004052", 02:45:02 INFO - "stage_platform": "macosx64", 02:45:02 INFO - "basedir": "/builds/slave/test", 02:45:02 INFO - "nightly_build": "True", 02:45:02 INFO - "buildnumber": 209, 02:45:02 INFO - "slavename": "t-yosemite-r7-0098", 02:45:02 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:45:02 INFO - "platform": "yosemite_r7", 02:45:02 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:45:02 INFO - "branch": "mozilla-aurora", 02:45:02 INFO - "repo_path": "releases/mozilla-aurora", 02:45:02 INFO - "revision": "6d030cb1d2ab43b99cc2b5b585d9acbdf6fc9e35", 02:45:02 INFO - "pgo_build": "False", 02:45:02 INFO - "builduid": "8397bc14f3f844e6a4f27c6548e15089", 02:45:02 INFO - "slavebuilddir": "test" 02:45:02 INFO - } 02:45:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 02:45:02 INFO - Running post-action listener: _resource_record_post_action 02:45:02 INFO - ##### 02:45:02 INFO - ##### Running download-and-extract step. 02:45:02 INFO - ##### 02:45:02 INFO - Running pre-action listener: _resource_record_pre_action 02:45:02 INFO - Running main action method: download_and_extract 02:45:02 INFO - mkdir: /builds/slave/test/build/tests 02:45:02 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')]} 02:45:02 INFO - https://queue.taskcluster.net/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:45:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:45:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:45:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbxj1ba5S9yfa5QVHqJQFw/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 02:45:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbxj1ba5S9yfa5QVHqJQFw/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 02:45:07 INFO - Downloaded 1277 bytes. 02:45:07 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 02:45:07 INFO - Using the following test package requirements: 02:45:07 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:45:07 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:45:07 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 02:45:07 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:45:07 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 02:45:07 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:45:07 INFO - u'jsshell-mac.zip'], 02:45:07 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:45:07 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 02:45:07 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:45:07 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:45:07 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 02:45:07 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:45:07 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 02:45:07 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:45:07 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 02:45:07 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:45:07 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:45:07 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 02:45:07 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:07 INFO - https://queue.taskcluster.net/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:45:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:45:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:45:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbxj1ba5S9yfa5QVHqJQFw/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 02:45:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbxj1ba5S9yfa5QVHqJQFw/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 02:45:10 INFO - Downloaded 17868393 bytes. 02:45:10 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'] 02:45:10 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 02:45:13 INFO - Return code: 0 02:45:13 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 02:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:13 INFO - https://queue.taskcluster.net/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:45:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:45:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:45:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbxj1ba5S9yfa5QVHqJQFw/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 02:45:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbxj1ba5S9yfa5QVHqJQFw/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 02:45:16 INFO - Downloaded 17868393 bytes. 02:45:16 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'] 02:45:16 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 02:45:19 INFO - Return code: 0 02:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:19 INFO - https://queue.taskcluster.net/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:45:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:45:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:45:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbxj1ba5S9yfa5QVHqJQFw/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 02:45:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbxj1ba5S9yfa5QVHqJQFw/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 02:45:21 INFO - Downloaded 10845161 bytes. 02:45:21 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'] 02:45:21 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 02:45:21 INFO - Return code: 0 02:45:21 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')]} 02:45:21 INFO - https://queue.taskcluster.net/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:45:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:45:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:45:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 02:45:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbxj1ba5S9yfa5QVHqJQFw/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 02:45:28 INFO - Downloaded 115147785 bytes. 02:45:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:45:28 INFO - mkdir: /builds/slave/test/properties 02:45:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:45:28 INFO - Writing to file /builds/slave/test/properties/build_url 02:45:28 INFO - Contents: 02:45:28 INFO - build_url:https://queue.taskcluster.net/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:45:29 INFO - Running post-action listener: _resource_record_post_action 02:45:29 INFO - Running post-action listener: set_extra_try_arguments 02:45:29 INFO - ##### 02:45:29 INFO - ##### Running populate-webroot step. 02:45:29 INFO - ##### 02:45:29 INFO - Running pre-action listener: _resource_record_pre_action 02:45:29 INFO - Running main action method: populate_webroot 02:45:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:45:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:45:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:45:29 INFO - '--tppagecycles', 02:45:29 INFO - '7'], 02:45:29 INFO - 'tests': ['tsvgm']}}, 02:45:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:45:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:45:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:45:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:45:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:45:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:45:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:45:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:29 INFO - 'talos_options': ['--e10s'], 02:45:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:45:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:29 INFO - 'tests': ['damp', 'tps']}, 02:45:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:29 INFO - 'talos_options': ['--e10s'], 02:45:29 INFO - 'tests': ['damp', 'tps']}, 02:45:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:45:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:45:29 INFO - 'other': {'tests': ['a11yr', 02:45:29 INFO - 'ts_paint', 02:45:29 INFO - 'tpaint', 02:45:29 INFO - 'sessionrestore', 02:45:29 INFO - 'sessionrestore_no_auto_restore', 02:45:29 INFO - 'tabpaint']}, 02:45:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:45:29 INFO - 'tests': ['a11yr', 02:45:29 INFO - 'ts_paint', 02:45:29 INFO - 'tpaint', 02:45:29 INFO - 'sessionrestore', 02:45:29 INFO - 'sessionrestore_no_auto_restore', 02:45:29 INFO - 'tabpaint']}, 02:45:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:45:29 INFO - 'tests': ['a11yr', 02:45:29 INFO - 'ts_paint', 02:45:29 INFO - 'tpaint', 02:45:29 INFO - 'sessionrestore', 02:45:29 INFO - 'sessionrestore_no_auto_restore', 02:45:29 INFO - 'tabpaint']}, 02:45:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:45:29 INFO - 'tests': ['a11yr', 02:45:29 INFO - 'ts_paint', 02:45:29 INFO - 'tpaint', 02:45:29 INFO - 'sessionrestore', 02:45:29 INFO - 'sessionrestore_no_auto_restore', 02:45:29 INFO - 'tabpaint']}, 02:45:29 INFO - 'other_l64': {'tests': ['a11yr', 02:45:29 INFO - 'ts_paint', 02:45:29 INFO - 'tpaint', 02:45:29 INFO - 'sessionrestore', 02:45:29 INFO - 'sessionrestore_no_auto_restore', 02:45:29 INFO - 'tabpaint']}, 02:45:29 INFO - 'other_nol64': {'tests': ['a11yr', 02:45:29 INFO - 'ts_paint', 02:45:29 INFO - 'tpaint', 02:45:29 INFO - 'sessionrestore', 02:45:29 INFO - 'sessionrestore_no_auto_restore', 02:45:29 INFO - 'tabpaint']}, 02:45:29 INFO - 'svgr': {'tests': ['tsvgx', 02:45:29 INFO - 'tsvgr_opacity', 02:45:29 INFO - 'tart', 02:45:29 INFO - 'tscrollx', 02:45:29 INFO - 'cart']}, 02:45:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:45:29 INFO - 'tests': ['tsvgx', 02:45:29 INFO - 'tsvgr_opacity', 02:45:29 INFO - 'tart', 02:45:29 INFO - 'tscrollx', 02:45:29 INFO - 'cart']}, 02:45:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:29 INFO - 'tests': ['tp5o']}, 02:45:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:29 INFO - 'talos_options': ['--e10s'], 02:45:29 INFO - 'tests': ['tp5o']}, 02:45:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:29 INFO - 'talos_options': ['--xperf_path', 02:45:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:45:29 INFO - 'tests': ['tp5n']}, 02:45:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:45:29 INFO - 'talos_options': ['--e10s', 02:45:29 INFO - '--xperf_path', 02:45:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:45:29 INFO - 'tests': ['tp5n']}}, 02:45:29 INFO - 'talos.zip': {'path': '', 02:45:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:45:29 INFO - Running post-action listener: _resource_record_post_action 02:45:29 INFO - ##### 02:45:29 INFO - ##### Running create-virtualenv step. 02:45:29 INFO - ##### 02:45:29 INFO - Running pre-action listener: _resource_record_pre_action 02:45:29 INFO - Running main action method: create_virtualenv 02:45:29 INFO - Creating virtualenv /builds/slave/test/build/venv 02:45:29 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 02:45:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:45:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:45:29 INFO - Using real prefix '/tools/python27' 02:45:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:45:30 INFO - Installing distribute.............................................................................................................................................................................................done. 02:45:33 INFO - Installing pip.................done. 02:45:33 INFO - Return code: 0 02:45:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:33 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 0x1041b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041bf4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bb4508a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10405cd30>, '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 0x103ec0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104053b20>, '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.9yMun4gGIB/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.ynVyBprsik/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 02:45:33 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 02:45:33 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 02:45:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yMun4gGIB/Render', 02:45:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:33 INFO - 'HOME': '/Users/cltbld', 02:45:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:33 INFO - 'LOGNAME': 'cltbld', 02:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:33 INFO - 'MOZ_NO_REMOTE': '1', 02:45:33 INFO - 'NO_EM_RESTART': '1', 02:45:33 INFO - 'PAGER': '/bin/cat', 02:45:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:33 INFO - 'PWD': '/builds/slave/test', 02:45:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:33 INFO - 'SHELL': '/bin/bash', 02:45:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ynVyBprsik/Listeners', 02:45:33 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 02:45:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:33 INFO - 'USER': 'cltbld', 02:45:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:33 INFO - 'XPC_FLAGS': '0x0', 02:45:33 INFO - 'XPC_SERVICE_NAME': '0', 02:45:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:33 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 02:45:33 INFO - Cleaning up... 02:45:33 INFO - Return code: 0 02:45:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:33 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 0x1041b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041bf4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bb4508a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10405cd30>, '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 0x103ec0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104053b20>, '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.9yMun4gGIB/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.ynVyBprsik/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 02:45:33 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 02:45:33 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 02:45:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yMun4gGIB/Render', 02:45:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:33 INFO - 'HOME': '/Users/cltbld', 02:45:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:33 INFO - 'LOGNAME': 'cltbld', 02:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:33 INFO - 'MOZ_NO_REMOTE': '1', 02:45:33 INFO - 'NO_EM_RESTART': '1', 02:45:33 INFO - 'PAGER': '/bin/cat', 02:45:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:33 INFO - 'PWD': '/builds/slave/test', 02:45:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:33 INFO - 'SHELL': '/bin/bash', 02:45:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ynVyBprsik/Listeners', 02:45:33 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 02:45:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:33 INFO - 'USER': 'cltbld', 02:45:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:33 INFO - 'XPC_FLAGS': '0x0', 02:45:33 INFO - 'XPC_SERVICE_NAME': '0', 02:45:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:33 INFO - Downloading/unpacking psutil>=0.7.1 02:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:45:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:45:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:45:36 INFO - Installing collected packages: psutil 02:45:36 INFO - Running setup.py install for psutil 02:45:36 INFO - building 'psutil._psutil_osx' extension 02:45:36 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 02:45:37 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 02:45:37 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 02:45:37 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 02:45:37 INFO - building 'psutil._psutil_posix' extension 02:45:37 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 02:45:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:45:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:45:37 INFO - ^ 02:45:37 INFO - 1 warning generated. 02:45:37 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 02:45:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:45:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:45:37 INFO - Successfully installed psutil 02:45:37 INFO - Cleaning up... 02:45:37 INFO - Return code: 0 02:45:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:45:37 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')]} 02:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:37 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')]} 02:45:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:37 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 0x1041b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041bf4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bb4508a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10405cd30>, '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 0x103ec0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104053b20>, '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.9yMun4gGIB/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.ynVyBprsik/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 02:45:37 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 02:45:37 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 02:45:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yMun4gGIB/Render', 02:45:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:37 INFO - 'HOME': '/Users/cltbld', 02:45:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:37 INFO - 'LOGNAME': 'cltbld', 02:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:37 INFO - 'MOZ_NO_REMOTE': '1', 02:45:37 INFO - 'NO_EM_RESTART': '1', 02:45:37 INFO - 'PAGER': '/bin/cat', 02:45:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:37 INFO - 'PWD': '/builds/slave/test', 02:45:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:37 INFO - 'SHELL': '/bin/bash', 02:45:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ynVyBprsik/Listeners', 02:45:37 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 02:45:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:37 INFO - 'USER': 'cltbld', 02:45:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:37 INFO - 'XPC_FLAGS': '0x0', 02:45:37 INFO - 'XPC_SERVICE_NAME': '0', 02:45:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:45:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:45:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:45:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:45:40 INFO - Installing collected packages: mozsystemmonitor 02:45:40 INFO - Running setup.py install for mozsystemmonitor 02:45:40 INFO - Successfully installed mozsystemmonitor 02:45:40 INFO - Cleaning up... 02:45:40 INFO - Return code: 0 02:45:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:45:40 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')]} 02:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:40 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')]} 02:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:40 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 0x1041b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041bf4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bb4508a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10405cd30>, '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 0x103ec0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104053b20>, '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.9yMun4gGIB/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.ynVyBprsik/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 02:45:40 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 02:45:40 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 02:45:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yMun4gGIB/Render', 02:45:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:40 INFO - 'HOME': '/Users/cltbld', 02:45:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:40 INFO - 'LOGNAME': 'cltbld', 02:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:40 INFO - 'MOZ_NO_REMOTE': '1', 02:45:40 INFO - 'NO_EM_RESTART': '1', 02:45:40 INFO - 'PAGER': '/bin/cat', 02:45:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:40 INFO - 'PWD': '/builds/slave/test', 02:45:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:40 INFO - 'SHELL': '/bin/bash', 02:45:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ynVyBprsik/Listeners', 02:45:40 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 02:45:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:40 INFO - 'USER': 'cltbld', 02:45:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:40 INFO - 'XPC_FLAGS': '0x0', 02:45:40 INFO - 'XPC_SERVICE_NAME': '0', 02:45:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:40 INFO - Downloading/unpacking blobuploader==1.2.4 02:45: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 02:45: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 02:45: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 02:45: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 02:45: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 02:45: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 02:45:43 INFO - Downloading blobuploader-1.2.4.tar.gz 02:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:45:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:45:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:45:44 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 02:45:44 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 02:45:44 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 02:45:44 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 02:45:44 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 02:45:44 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 02:45:44 INFO - Downloading docopt-0.6.1.tar.gz 02:45:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:45:44 INFO - Installing collected packages: blobuploader, requests, docopt 02:45:44 INFO - Running setup.py install for blobuploader 02:45:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:45:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:45:44 INFO - Running setup.py install for requests 02:45:45 INFO - Running setup.py install for docopt 02:45:45 INFO - Successfully installed blobuploader requests docopt 02:45:45 INFO - Cleaning up... 02:45:45 INFO - Return code: 0 02:45:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:45 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 0x1041b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041bf4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bb4508a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10405cd30>, '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 0x103ec0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104053b20>, '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.9yMun4gGIB/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.ynVyBprsik/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 02:45:45 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 02:45:45 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 02:45:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yMun4gGIB/Render', 02:45:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:45 INFO - 'HOME': '/Users/cltbld', 02:45:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:45 INFO - 'LOGNAME': 'cltbld', 02:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:45 INFO - 'MOZ_NO_REMOTE': '1', 02:45:45 INFO - 'NO_EM_RESTART': '1', 02:45:45 INFO - 'PAGER': '/bin/cat', 02:45:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:45 INFO - 'PWD': '/builds/slave/test', 02:45:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:45 INFO - 'SHELL': '/bin/bash', 02:45:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ynVyBprsik/Listeners', 02:45:45 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 02:45:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:45 INFO - 'USER': 'cltbld', 02:45:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:45 INFO - 'XPC_FLAGS': '0x0', 02:45:45 INFO - 'XPC_SERVICE_NAME': '0', 02:45:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:45:45 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-lC25fB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:45:45 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-y3sh9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:45:45 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-JTOTfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:45:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-x1E1Pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:45:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-7rU9Sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:45:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-Pd3LCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:45:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-YjrJ1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:45:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-SPr3L8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:45:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-36wH_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:45:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-gP0qDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:45:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-xf9VvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:45:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-64fO9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:45:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-fF5BT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:45:47 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-4CCA7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:47 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-V_SWce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:45:47 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-w73YZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:45:47 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-XZlZNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:45:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:45:47 INFO - Running setup.py install for manifestparser 02:45:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:45:47 INFO - Running setup.py install for mozcrash 02:45:47 INFO - Running setup.py install for mozdebug 02:45:47 INFO - Running setup.py install for mozdevice 02:45:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:45:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:45:48 INFO - Running setup.py install for mozfile 02:45:48 INFO - Running setup.py install for mozhttpd 02:45:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:45:48 INFO - Running setup.py install for mozinfo 02:45:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:45:48 INFO - Running setup.py install for mozInstall 02:45:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:45:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:45:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:45:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:45:48 INFO - Running setup.py install for mozleak 02:45:48 INFO - Running setup.py install for mozlog 02:45:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:45:48 INFO - Running setup.py install for moznetwork 02:45:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:45:49 INFO - Running setup.py install for mozprocess 02:45:49 INFO - Running setup.py install for mozprofile 02:45:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:45:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:45:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:45:49 INFO - Running setup.py install for mozrunner 02:45:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:45:49 INFO - Running setup.py install for mozscreenshot 02:45:49 INFO - Running setup.py install for moztest 02:45:49 INFO - Running setup.py install for mozversion 02:45:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:45:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:45:49 INFO - Cleaning up... 02:45:49 INFO - Return code: 0 02:45:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:50 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')]} 02:45:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:50 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 0x1041b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041bf4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bb4508a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10405cd30>, '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 0x103ec0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104053b20>, '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.9yMun4gGIB/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.ynVyBprsik/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 02:45:50 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 02:45:50 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 02:45:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yMun4gGIB/Render', 02:45:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:50 INFO - 'HOME': '/Users/cltbld', 02:45:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:50 INFO - 'LOGNAME': 'cltbld', 02:45:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:50 INFO - 'MOZ_NO_REMOTE': '1', 02:45:50 INFO - 'NO_EM_RESTART': '1', 02:45:50 INFO - 'PAGER': '/bin/cat', 02:45:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:50 INFO - 'PWD': '/builds/slave/test', 02:45:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:50 INFO - 'SHELL': '/bin/bash', 02:45:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ynVyBprsik/Listeners', 02:45:50 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 02:45:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:50 INFO - 'USER': 'cltbld', 02:45:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:50 INFO - 'XPC_FLAGS': '0x0', 02:45:50 INFO - 'XPC_SERVICE_NAME': '0', 02:45:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:45:50 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-sMrlXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:45:50 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)) 02:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:45:50 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-7UfHdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:45:50 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)) 02:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:45:50 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-TzacXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:45:50 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)) 02:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:45:50 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-LZujdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:45:50 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)) 02:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:45:50 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-TRr51r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:45:50 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)) 02:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:45:50 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-6BNvGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:45:50 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)) 02:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:45:50 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-M19IFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:45:51 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)) 02:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:45:51 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-wFkK9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:45:51 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)) 02:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:45:51 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-afGcqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:45:51 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)) 02:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:45:51 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-ugrqWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:45:51 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)) 02:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:45:51 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-XCkHGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:45:51 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)) 02:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:45:51 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-HQOhIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:45:51 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)) 02:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:45:51 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-nF_6iW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:45:51 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)) 02:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:45:51 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-xVDDKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:45:51 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)) 02:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:51 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-woVanq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:51 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)) 02:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:45:51 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-2HBndm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:45:52 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)) 02:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:45:52 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-in_HqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:45:52 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)) 02:45:52 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)) 02:45:52 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)) 02:45:52 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)) 02:45:52 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)) 02:45:52 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)) 02:45:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:45: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 02:45: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 02:45: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 02:45: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 02:45: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 02:45: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 02:45:54 INFO - Downloading blessings-1.6.tar.gz 02:45:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:45:54 INFO - Installing collected packages: blessings 02:45:54 INFO - Running setup.py install for blessings 02:45:54 INFO - Successfully installed blessings 02:45:54 INFO - Cleaning up... 02:45:54 INFO - Return code: 0 02:45:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:45:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:45:55 INFO - Reading from file tmpfile_stdout 02:45:55 INFO - Current package versions: 02:45:55 INFO - blessings == 1.6 02:45:55 INFO - blobuploader == 1.2.4 02:45:55 INFO - docopt == 0.6.1 02:45:55 INFO - manifestparser == 1.1 02:45:55 INFO - mozInstall == 1.12 02:45:55 INFO - mozcrash == 0.17 02:45:55 INFO - mozdebug == 0.1 02:45:55 INFO - mozdevice == 0.48 02:45:55 INFO - mozfile == 1.2 02:45:55 INFO - mozhttpd == 0.7 02:45:55 INFO - mozinfo == 0.9 02:45:55 INFO - mozleak == 0.1 02:45:55 INFO - mozlog == 3.1 02:45:55 INFO - moznetwork == 0.27 02:45:55 INFO - mozprocess == 0.22 02:45:55 INFO - mozprofile == 0.28 02:45:55 INFO - mozrunner == 6.11 02:45:55 INFO - mozscreenshot == 0.1 02:45:55 INFO - mozsystemmonitor == 0.0 02:45:55 INFO - moztest == 0.7 02:45:55 INFO - mozversion == 1.4 02:45:55 INFO - psutil == 3.1.1 02:45:55 INFO - requests == 1.2.3 02:45:55 INFO - wsgiref == 0.1.2 02:45:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45: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')]} 02:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45: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')]} 02:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:55 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 0x1041b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041bf4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bb4508a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10405cd30>, '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 0x103ec0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104053b20>, '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.9yMun4gGIB/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.ynVyBprsik/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 02:45:55 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 02:45:55 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 02:45:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yMun4gGIB/Render', 02:45:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:55 INFO - 'HOME': '/Users/cltbld', 02:45:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:55 INFO - 'LOGNAME': 'cltbld', 02:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:55 INFO - 'MOZ_NO_REMOTE': '1', 02:45:55 INFO - 'NO_EM_RESTART': '1', 02:45:55 INFO - 'PAGER': '/bin/cat', 02:45:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:55 INFO - 'PWD': '/builds/slave/test', 02:45:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:55 INFO - 'SHELL': '/bin/bash', 02:45:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ynVyBprsik/Listeners', 02:45:55 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 02:45:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:55 INFO - 'USER': 'cltbld', 02:45:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:55 INFO - 'XPC_FLAGS': '0x0', 02:45:55 INFO - 'XPC_SERVICE_NAME': '0', 02:45:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:55 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)) 02:45:55 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)) 02:45:55 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)) 02:45:55 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)) 02:45:55 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)) 02:45:55 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)) 02:45:55 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)) 02:45:55 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)) 02:45:55 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)) 02:45:55 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)) 02:45:55 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)) 02:45:55 INFO - Cleaning up... 02:45:55 INFO - Return code: 0 02:45:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:45: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')]} 02:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45: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')]} 02:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:55 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 0x1041b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041bf4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bb4508a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10405cd30>, '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 0x103ec0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104053b20>, '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.9yMun4gGIB/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.ynVyBprsik/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 02:45:55 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 02:45:55 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 02:45:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yMun4gGIB/Render', 02:45:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:55 INFO - 'HOME': '/Users/cltbld', 02:45:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:55 INFO - 'LOGNAME': 'cltbld', 02:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:55 INFO - 'MOZ_NO_REMOTE': '1', 02:45:55 INFO - 'NO_EM_RESTART': '1', 02:45:55 INFO - 'PAGER': '/bin/cat', 02:45:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:55 INFO - 'PWD': '/builds/slave/test', 02:45:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:55 INFO - 'SHELL': '/bin/bash', 02:45:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ynVyBprsik/Listeners', 02:45:55 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 02:45:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:55 INFO - 'USER': 'cltbld', 02:45:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:55 INFO - 'XPC_FLAGS': '0x0', 02:45:55 INFO - 'XPC_SERVICE_NAME': '0', 02:45:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:55 INFO - Downloading/unpacking jsonschema 02:45:55 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 02:45:55 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 02:45:55 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 02:45:55 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 02:45:55 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 02:45:55 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 02:45:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:45:57 INFO - Downloading/unpacking functools32 (from jsonschema) 02:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:58 INFO - Downloading functools32-3.2.3-2.tar.gz 02:45:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:45:58 INFO - warning: no files found matching '*.txt' 02:45:58 INFO - no previously-included directories found matching 'build' 02:45:58 INFO - no previously-included directories found matching 'dist' 02:45:58 INFO - no previously-included directories found matching '.git*' 02:45:58 INFO - Installing collected packages: jsonschema, functools32 02:45:58 INFO - Running setup.py install for functools32 02:45:58 INFO - warning: no files found matching '*.txt' 02:45:58 INFO - no previously-included directories found matching 'build' 02:45:58 INFO - no previously-included directories found matching 'dist' 02:45:58 INFO - no previously-included directories found matching '.git*' 02:45:58 INFO - Successfully installed jsonschema functools32 02:45:58 INFO - Cleaning up... 02:45:58 INFO - Return code: 0 02:45:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:45:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1041b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041bf4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0bb4508a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10405cd30>, '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 0x103ec0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104053b20>, '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.9yMun4gGIB/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.ynVyBprsik/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 02:45:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:45:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yMun4gGIB/Render', 02:45:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:58 INFO - 'HOME': '/Users/cltbld', 02:45:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:58 INFO - 'LOGNAME': 'cltbld', 02:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:58 INFO - 'MOZ_NO_REMOTE': '1', 02:45:58 INFO - 'NO_EM_RESTART': '1', 02:45:58 INFO - 'PAGER': '/bin/cat', 02:45:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:58 INFO - 'PWD': '/builds/slave/test', 02:45:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:58 INFO - 'SHELL': '/bin/bash', 02:45:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ynVyBprsik/Listeners', 02:45:58 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 02:45:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:58 INFO - 'USER': 'cltbld', 02:45:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:58 INFO - 'XPC_FLAGS': '0x0', 02:45:58 INFO - 'XPC_SERVICE_NAME': '0', 02:45:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:58 INFO - Downloading/unpacking flake8 02:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:46:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:46:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:46:02 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 02:46:02 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 02:46:02 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 02:46:02 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 02:46:02 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 02:46:02 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 02:46:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:46:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:46:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:46:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:46:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:46:02 INFO - no previously-included directories found matching 'docs/_build' 02:46:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:46:02 INFO - Running setup.py install for pep8 02:46:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:46:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:46:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:46:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:46:02 INFO - no previously-included directories found matching 'docs/_build' 02:46:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:46:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:46:02 INFO - Cleaning up... 02:46:02 INFO - Return code: 0 02:46:02 INFO - Running post-action listener: _resource_record_post_action 02:46:02 INFO - Running post-action listener: _start_resource_monitoring 02:46:02 INFO - Starting resource monitoring. 02:46:02 INFO - ##### 02:46:02 INFO - ##### Running install step. 02:46:02 INFO - ##### 02:46:02 INFO - Running pre-action listener: _resource_record_pre_action 02:46:02 INFO - Running main action method: install 02:46:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:46:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:46:03 INFO - Reading from file tmpfile_stdout 02:46:03 INFO - Detecting whether we're running mozinstall >=1.0... 02:46:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:46:03 INFO - Reading from file tmpfile_stdout 02:46:03 INFO - Output received: 02:46:03 INFO - Usage: mozinstall [options] installer 02:46:03 INFO - Options: 02:46:03 INFO - -h, --help show this help message and exit 02:46:03 INFO - -d DEST, --destination=DEST 02:46:03 INFO - Directory to install application into. [default: 02:46:03 INFO - "/builds/slave/test"] 02:46:03 INFO - --app=APP Application being installed. [default: firefox] 02:46:03 INFO - mkdir: /builds/slave/test/build/application 02:46:03 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'] 02:46:03 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 02:46:35 INFO - Reading from file tmpfile_stdout 02:46:35 INFO - Output received: 02:46:35 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:46:35 INFO - Running post-action listener: _resource_record_post_action 02:46:35 INFO - ##### 02:46:35 INFO - ##### Running run-tests step. 02:46:35 INFO - ##### 02:46:35 INFO - Running pre-action listener: _resource_record_pre_action 02:46:35 INFO - Running main action method: run_tests 02:46:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:46:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:46:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:46:35 INFO - 2016-03-19 02:46:35.492 screenresolution[1645:7743] starting screenresolution argv=screenresolution get 02:46:35 INFO - 2016-03-19 02:46:35.494 screenresolution[1645:7743] Display 0: 1600x1200x32@60 02:46:35 INFO - 2016-03-19 02:46:35.500 screenresolution[1646:7746] starting screenresolution argv=screenresolution list 02:46:35 INFO - Available Modes on Display 0 02:46:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:46:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:46:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:46:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:46:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:46:35 INFO - Intel Iris: 02:46:35 INFO - Chipset Model: Intel Iris 02:46:35 INFO - Type: GPU 02:46:35 INFO - Bus: Built-In 02:46:35 INFO - VRAM (Dynamic, Max): 1536 MB 02:46:35 INFO - Vendor: Intel (0x8086) 02:46:35 INFO - Device ID: 0x0a2e 02:46:35 INFO - Revision ID: 0x0009 02:46:35 INFO - Displays: 02:46:35 INFO - Display: 02:46:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:46:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:46:35 INFO - Display Serial Number: 1600x1200 60 02:46:35 INFO - Main Display: Yes 02:46:35 INFO - Mirror: Off 02:46:35 INFO - Online: Yes 02:46:35 INFO - Rotation: Supported 02:46:35 INFO - Return code: 0 02:46:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:46:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:46:35 INFO - Python 2.7.3 02:46:35 INFO - Return code: 0 02:46:35 INFO - grabbing minidump binary from tooltool 02:46: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')]} 02:46:35 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 0x10405cd30>, '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 0x103ec0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104053b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:46:35 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 02:46:35 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 02:46:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:46:35 INFO - Return code: 0 02:46:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:46:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:46:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:46:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:46:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:46:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:46:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:46:37 INFO - Return code: 0 02:46:37 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-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0098', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:46:37 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-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0098 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:46:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yMun4gGIB/Render', 02:46:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:37 INFO - 'HOME': '/Users/cltbld', 02:46:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:37 INFO - 'LOGNAME': 'cltbld', 02:46:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:46:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:37 INFO - 'MOZ_NO_REMOTE': '1', 02:46:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:46:37 INFO - 'NO_EM_RESTART': '1', 02:46:37 INFO - 'PAGER': '/bin/cat', 02:46:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:37 INFO - 'PWD': '/builds/slave/test', 02:46:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:46:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:37 INFO - 'SHELL': '/bin/bash', 02:46:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ynVyBprsik/Listeners', 02:46:37 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 02:46:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:37 INFO - 'USER': 'cltbld', 02:46:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:37 INFO - 'XPC_FLAGS': '0x0', 02:46:37 INFO - 'XPC_SERVICE_NAME': '0', 02:46:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0098', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:46:37 INFO - mozversion application_buildid: 20160319004052 02:46:37 INFO - mozversion application_changeset: 6d030cb1d2ab43b99cc2b5b585d9acbdf6fc9e35 02:46:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:46:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:46:37 INFO - mozversion application_name: Firefox 02:46:37 INFO - mozversion application_remotingname: firefox-dev 02:46:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:46:37 INFO - mozversion application_vendor: Mozilla 02:46:37 INFO - mozversion application_version: 47.0a2 02:46:37 INFO - mozversion platform_buildid: 20160319004052 02:46:37 INFO - mozversion platform_changeset: 6d030cb1d2ab43b99cc2b5b585d9acbdf6fc9e35 02:46:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:46:37 INFO - mozversion platform_version: 47.0a2 02:46:37 INFO - using testdate: 1458380797 02:46:37 INFO - actual date: 1458380797 02:46:37 INFO - starting webserver on 'localhost:49272' 02:46:37 INFO - SUITE-START | Running 2 tests 02:46:37 INFO - TEST-START | dromaeo_css 02:46:37 INFO - operating with platform_type : mac_ 02:46:37 INFO - Initialising browser for dromaeo_css test... 02:46:37 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpadxkS4/profile http://localhost:49272/getInfo.html) 02:46:40 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 02:46:40 INFO - PROCESS | 1664 | colorDepth:24 02:46:40 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 02:46:40 INFO - PROCESS | 1664 | __metrics 02:46:40 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 02:46:40 INFO - TEST-INFO | 1664: exit 0 02:46:40 INFO - Browser initialized. 02:46:40 INFO - Running cycle 1/1 for dromaeo_css test... 02:46:40 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpadxkS4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:46:52 INFO - PROCESS | 1668 | RSS: Main: 219713536 02:46:52 INFO - PROCESS | 1668 | 02:47:42 INFO - PROCESS | 1668 | 1458380862552 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] 02:49:53 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 02:49:54 INFO - PROCESS | 1668 | RSS: Main: 230686720 02:49:54 INFO - PROCESS | 1668 | 02:52:56 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 02:52:57 INFO - PROCESS | 1668 | RSS: Main: 243593216 02:52:57 INFO - PROCESS | 1668 | 02:55:59 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 02:55:59 INFO - PROCESS | 1668 | RSS: Main: 244817920 02:55:59 INFO - PROCESS | 1668 | 02:59:01 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 02:59:02 INFO - PROCESS | 1668 | RSS: Main: 247066624 02:59:02 INFO - PROCESS | 1668 | 03:02:04 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 03:02:05 INFO - PROCESS | 1668 | RSS: Main: 249253888 03:02:05 INFO - PROCESS | 1668 | 03:05:07 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 03:05:07 INFO - PROCESS | 1668 | RSS: Main: 251392000 03:05:07 INFO - PROCESS | 1668 | 03:05:07 INFO - PROCESS | 1668 | __start_tp_report 03:05:07 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 03:05:07 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 03:05:07 INFO - PROCESS | 1668 | |i|pagename|runs| 03:05:07 INFO - PROCESS | 1668 | |0;dojo.html;3507.473878918162;3526.841292141854;3562.946555801665;3569.750117491775;3590.407582748845;5796.797112101067;5808.647497763402;5819.476247137757;5839.824805255838;5851.356350801409;5786.450287222718;5805.5936084474;5812.1281807728865;5848.444397782215;5894.322152952412;4047.6154765297397;4464.97767511162;4845.885446347343;5206.687598744078;5255.816046438375;4209.873703788891;5258.763355648985;5283.07546179419;5339.759710813023;5344.679319240839;5296.126139187029;5302;5307.946920530803;5311.787528498855;5332.280142180794;5294.735263236823;5303.257543943851;5332.92000619991;5348.839534813942;5350.411454739976;4271.252530807096;5048.192289233742;5120;5191.169412893919;5224.813381737054;5527.198556209368;5679.488846003879;5679.7160141993145;5699.373068962411;5735.139729040678;5301.73491325436;5450.264214331054;6139.631622102688;6312.52656050798;6328.65192414417;6258.843528911768;6263.31103578606;6280.842978925518;6299.401556852137;6314.400131987454;5280.498352656491;5420.430854760233;5989.700514974277;6036.577439579275;6068.362821903636;6263.248410190807;6421.486281097501;6426.485881129498;6483.3192514786215;6488.578242414228;6135.324535308531;6241.21984751906;6255.12428260044;6263;6286.057091436322;6270.216222972129;6328.557001009977;6329.873402531924;6340.270868850049;6358.1734374531015;6145.740123274718;6149.477294430024;6186.4741496973265;6203.7828675996125;6254.530910181664;6232.25212974446;6232.750689972441;6256.061590761422;6259.155014073133;6260.937390626126;4972.303877457159;5005.249212618136;5009.348784658044;5017.84946451607;5021.94539146776;4389.956100438954;4400.713953593006;4484.529124441952;4499.662525310615;4518.751468669189;5738.282714660668;5871.970640146772;5882.823515294548;5924.822255332347;5940.376260492672;6245.469135123474;6246.187995560548;6282.968585157045;6296.087067375205;6315.968420157962;5628.127640215773;5786.2477877876445;5801.042827933428;5810.796622118206;5833.88332233353;5393.110136827379;5411.56707463402;5431.864203394946;5441.700706461103;5455.699936503531;6411.647359395278;6422.197225346832;6422.710978005907;6423.293437721847;6431.389018043278;5211.400688920671;5616.326040875121;5919.964006298795;6223.408776166257;6287.1512345832725;6406.359364063556;6409.9679501602195;6421.903671444838;6424.678766061772;6518.934810651833;6257.843553911189;6266.279377871603;6266.749330026748;6267.934451143407;6273.52948528853;6228.9722195838995;6232.781852635136;6280.183576135073;6289;6320.4311611955145;5030.698158110378;5870.412958704095;6242.500599951902;6254.8123556293385;6258.593191442542;6063.272407310975;6214.627122372672;6234.1583886174785;6240.438360547391;6243.562950593415;5987.401259873977;6023.548233882389;6122.184701511214;6132.936844521141;6163.137160797402;6135.478484328703;6210.844728881814;6221.502279817513;6224.564280500322;6236.064590311489;5953.970230148995;6100.816975490742;6108.541859360477;6150.169727086786;6155.2613686356135 03:05:07 INFO - PROCESS | 1668 | |1;ext.html;460.67292222521985;493.3044407385587;571.8734093835146;575.9805144893538;587.3187102960567;38932.41601375978;39471.60528394715;39475.80262098689;39487.815365539005;39490.01274968127;33106.8344658277;40361.59638403615;40654.59345406545;40956.18087638253;41169.382459263135;9518.952405237982;9623.03769623039;9698.321117521777;9762;9763.414195148278;9420.81158376832;9594.136527712504;9602.279829012818;9625.855612165788;9655.75860603487;7634.00757901472;9516.572514122869;9580.856287155699;9647.565859536302;9703.07820757027;9225.12361325673;9592.90407095927;9595.568199431042;9634.373765705206;9666.951665241699;9605.231581473465;9752.804943901083;9754.0733630305;9774.26692998021;9779.022097790235;39387.21225575501;39983.40024899629;39989.40015899764;40169.196616067806;40350;2935.5743417204385;3003.594514740526;3295.736341092731;3307.074019274607;3376.1053320869987;28789.856050719613;29593.964211252503;29685.851570742223;29897.701022989928;31270;2787.317107308702;2811.4939310924024;2846.6299381080325;2846.6584009918943;2929.282325830185;374215.12892435637;406014;406504.9674751637;408879;411248.8875111241;48142.75928620334;69095.65452172708;69113.61772764516;69542.65228673824;69645;46379.5362046382;46888.531114689096;46927.949683270475;47111.5288847114;47152.76423617928;16329.510114696579;16428.835711642732;16641.167941603115;16670;16720.913140646062;13034.784086705284;13113.672158196121;13170.143940643828;13218.801717974238;13246.271455070064;15032.549023529311;15287.847121528865;15397.384104635688;15548.455804046804;15619.921900390653;6728.158980127484;6788.422984046312;6821.488388370793;6841;6881.13985751781;892.9329451305628;958.9520523973773;1003.1072345612411;1037.7976294622476;1044.4307852220406;30373.848130759205;30457.847710761303;30926;31072.68927310698;31142;1106.778644271149;1109.5062697099713;1152.4007516091585;1153.1697178031804;1171.2562522797914;14812.481563145238;14825.92587037058;14829.703405932038;14903;15028.924855375653;610404;612464;614699;620819;624671;62242;62365.68817155976;63112.737745244835;63146.68426657837;63197.368026320066;1530.9770353444708;1550.968980620404;1557.0424189123607;1557.8520040596125;1663.8003439587085;27042.864785675945;28543.28641783972;28985.98549050773;29067.563986539797;29162.708372916;46503.83740406517;50935;51769.741151294;51839.74080129575;51858.481415185364;455778;456049;457494;457672;459800;33364;45438.091238175715;45742.542574573825;47480.52519474761;47535.76232118817;44715.32927006163;44807.55192448164;45042;45382.77308613436;46475;31746.841265794446;37451.30248785263;37654.62345376511;38685;39481;37671;37954.620453795105;38113;38385.808070960586;38685.80657096697;32501.02496925096;35774;37667.623323767504;39121.804390977864;39124;31748.523772143897;32479;32481;32522.51216231711;32769.180770480925;23259.418514536595;24675.506489869742;24902.007839372443;24992.000319987725;25375.238742837744 03:05:07 INFO - PROCESS | 1668 | |2;jquery.html;366.2857428015371;375.19895024123497;375.37125315097217;376.553783766237;378.62516109052046;20268.59462810743;20903.477413064662;21148.836813975224;21851.907404629783;21861.890690546526;20904.8954755226;21120.366389008315;21327.97384248494;21346.57306853862;21392.25127120551;5814.767409303623;5936.139259807325;6009.399060093978;6021.729022194012;6141.17094192285;5292.947070529303;5917.171595976567;6040.939590604104;6068.939310606882;6072.180255665473;5741.626794258381;6010.098485227207;6027.065804800263;6033.190042987108;6048.667323297217;5893.764249430018;5950.226470558843;5954.851128721773;5958.731857066421;5965.761369545213;5097.413797413271;5102.872428189325;5216.087184742692;5230.529252367305;5230.555402790729;26310.6053409199;26973.46053078947;27119.593206101923;27362.179134625992;27487.45025099487;2194.221051526701;2252.1554417093425;2336.0188720737333;2772.861356932145;2964.1996660901436;15145.167015814126;15314.234288285541;15338.003029803027;15506.844931550653;15621.375144994186;1575.4249698859949;1746.1880225694986;1791.6506281275156;1834.6972749496317;1860.748798912143;106180;107243.46378268137;109030.9999999992;109593;111547.88452115456;11181.944090279496;11419.543218271176;11623.186376953532;11638.359890205951;11757.412129393497;14070.577882663536;14102.294885255902;14121;14122.152670839783;14124.788128178085;9065;9096.954515227382;9206.585703643352;9277.118673725985;9322.533873306307;9533.189678877234;9535.427874327563;9592.853324273461;9649.276304277208;9775.560099795526;5710.029295019856;6299.779507717208;6314.652694101868;6737.59574425536;6847.760328388582;1595.968080638404;1673.4226691791312;1921.8654694171553;1947.9220831166879;1950.3953774330002;986.9538289413244;1023.8566600675912;1032.9741756455999;1060.2525219720078;1129.728865072393;21802.345929622137;22180.112795488323;22330.776692233194;22653.773462265497;22695.319140425814;1027.5119318323736;1050.3330385205297;1051.1380667852288;1054.9947250263854;1085.1752667972398;11493.195476316578;11941.52233910634;12134.575289864812;12195.817062744067;12196.695082623006;665230;670993;671888;673556;683542;96374;99295.51056734155;100443.49778251062;103965;104000;1103.757173421846;1114.0363585498646;1124.5558004588142;1128.1200663482496;1128.836318733779;18944.905275473535;19500.60998780045;19646.80353196507;19815;20088.79911200869;48939;49742;49949.50050499449;50556.747216263684;51282.48717512927;65333.69332613226;68480.65759671369;69377;69619.65190174017;69833.60332793214;8235.34117270605;8315.251627353568;8374.623141958748;8512.531810750468;8590.398672092893;13615.52345667897;13640.181589104686;13734.793978090536;13817.577320100785;14173.929130354281;11298.265612735146;11744.412779361168;11958.282503049844;12065.034797216025;12135.453904574491;11688.70778230551;11814.99572536344;11910.225835320676;12092.637220883387;12307.26156430617;11534.192606517463;11800;11866.76266474683;12048.578299759467;12133.514659413524;8319.916800831914;8362.665493380196;8415.831683366421;8500.6232859636;8506.914930850613;12025.939870300592;12030.939845301067;12115.394230288626;12188.390580471118;12244.510219591117 03:05:07 INFO - PROCESS | 1668 | |3;mootools.html;1671.8411750883665;1688.5440930948644;2007.548301632133;2020.8787472751635;2088.872009115078;8471.110533393998;8969.55152242387;9331.953340233298;9549.713508594754;9574.712758617245;9182.954085229581;9230.492322922237;9337.066293370677;9362.204212641916;9368.625254989793;2588.961165582513;2597.9610305845426;2600.401907561262;2601.479704059186;2614.398688301692;2542.275451496324;2577.226831950417;2600.2979195617268;2616.2020583721956;2616.699079605851;2573.395252115751;2592.93517662059;2595.6625638666947;2617.8429294242405;2620.89516419343;2489.8879550420183;2496.6379874918125;2517.2196619048154;2519.3323769201174;2520.0171932946164;2560.5263026340185;2573.266619013572;2589.3138318345655;2595.883185256668;2608.608708693711;9381.343305968585;9436.245100392021;9466.574004169828;9473.05269473054;9516.095970882825;5643.351014633287;5718.656880587178;5720.799772008001;5744.798932037401;5776.566757493205;3734.925301493955;3820.9617903820886;3857.6720978716844;3862.671672907806;3897.80510974453;1057.2546354819833;1064.9520771565221;1070.2936062198912;1118.3122379736485;1123.5056575107008;12417.689557761038;12464.626061218178;12497.00023998078;12604.684882878002;12707.237565746085;5008.474110218447;5093.617978651616;5134.768935397916;5207.609429292818;5208.0365132450615;10722.946385268024;10743;10764.515596798163;10787;10832.079273261861;5671.574631902624;5696.800611978644;5725.77096916127;5749.281339832521;5787.479126878601;4123.9175216496105;4837.588804951548;4987.775550100254;5046.949530504721;5096.898062038738;4137.40007698882;4164.708470407103;4187.225363307798;4193.1194449165405;4225.7887105644595;1355.2478374502048;1364.8908087352988;1375.326090215807;1376.6971266321593;1376.745302119111;1386.0367044903694;1392.046448182998;1411.4213172599184;1438.4893362856244;1455.1269238456841;7323.963380183065;8539.74380768578;8720.30237580992;8772.859528261286;8801.779955501035;1264.5131624324517;1269.504893091695;1272.179444258448;1274.0444666500125;1300.6878349196313;6520.47836173105;6589.077529145923;6613.107230523914;6652.06871038055;6659.733610655617;9045.321600879828;11472.082233421306;11490.368029758443;11505.367204803648;11527.48126334317;11166;11504.36725980079;11596.492455980668;11620.535178592761;11745.823812642817;8798.648054077765;8810.118988101267;8834.249088827393;8865;8926.419782714103;8131.186881311822;8238.629261683118;8383.161683831568;8446.36652251096;8471.025832029396;10058.295919285873;10229.335093218917;10258.076773090159;10322.948385258325;10360.689179324632;10391.636292729718;10522.789544209227;10533.262671612914;10608.416537090534;10680.679579612624;6731.764388246388;7190.604516751629;7332.340089391981;7443.55338679681;7571.886421703789;8625.482471051757;8648.827023459622;8681.8697719533;8699.391042627209;8713.085126061673;7509.9624501879325;7714.190010048864;7727.806804829925;7767.689292428239;7774.727884524014;7526.924730752622;7548.396128309612;7577.431692622965;7595.164531901376;7738.148803631709;8144.511329320259;8148.755537333889;8198.549079800669;8211;8215.712450064459;6246.562740608296;7237.131544214728;7302.160251571137;7320.377767889789;7413.2957369049855;7348.485606007528;7422.96288518554;7440;7476.364509016795;7490.1386340571535 03:05:07 INFO - PROCESS | 1668 | |4;prototype.html;263.3666033190178;312.20699423464396;337.70619560981964;341.41447417678677;341.62762588778236;6648.238216872526;6864.931350686492;6902.792916212522;6933.405316777144;7047.1895731990835;6815.795526134211;6895.586264824114;6896.724131034753;6905.136857892763;6917.100776898996;4784.354112194861;4945.480724523927;5017.67385119966;5056.317397151374;5071.1886098224295;5031.245313203012;5040.621953353495;5042.47054059324;5053.5957123430035;5062.367204099488;4995.325631039817;4998.475160108191;5019.52314530119;5023.547880690737;5025.341637259714;5016.021875734234;5019.096562618727;5020.447750747415;5029.723365214912;5032.849014529534;3586.9282614347826;4417.204903117437;4432.468103827529;4437.955620443787;4438.667099967483;5377.327834020747;5404.405515393303;6613.735450581971;6650.434713049397;6738.427233685143;5962.34414214436;6019.488343490809;6024.698765061729;6046.183765191687;6100.176476175704;7364.263573642646;7368.336849683501;7369.22623124575;7372.557646541225;7375.114986201636;4082.4692789937417;4941.160002799496;4946.752662366904;4956.1822299320565;4965.205567109281;6503.869922601569;7353.448491363116;7536.924630753677;7693.9615301923695;7820.687172513092;4827.42070951488;4930.580900623487;4985.700857948535;4987.351644286219;4989.201727723546;4208.558101399309;5071.264666623319;5083.898322033612;5087.186050232019;5095.439501654815;5961.821145365646;5964.642121472725;5987.760489580455;6026.789062382795;6042.637441753509;6676.499262555328;6699.43054840344;7353.0441042664115;7383.8154046149275;7451.068616422947;1717.5105095047852;1768.8761786674809;1794.0760508338217;1797.1014492753623;1799.064486467056;996.6196817407942;1148.1102145837044;1170.607846371458;1171.1392126786805;1182.7338848758961;6724;6767.39093481589;6778.186617605918;6780.440498685231;6828.487863410264;6336.714847831859;7449.813754656068;7565.962170189224;7586.165521792598;7601;6777.728890844311;6794.252632210453;6812.863742725217;6821.953413975787;6841.418479429205;3219.935601287961;3876.2828876657345;4009.917322323015;4034.8500677307416;4035.576264492186;6999.545029573062;7747.806304842311;7875.56684382353;7880.330171935335;7900.367970562341;7816.062072551216;7817.101033381234;7832.765017049498;7840.9215907841335;7845.686172553148;7895.565743884026;7981.561014144278;7985.800354991172;7991.200879912079;7991.440599158003;7449.515781474187;7677.808054798675;7709.537427754352;7717.2668596483245;7720;7489.70041198346;7503.699852006077;7542.509736867086;7546.547207167588;7557.168711441627;7979.880301795594;7995.960020199862;8002.999625046869;8006.399520036137;8022.879656805269;3867.8839634811;4949.737816856678;5049.217371307306;5091.465396133352;5100.336956195671;7345.595992220479;7622.656980436004;7648.80877978055;7672.117706463605;7672.5012874163;7345.55926644403;7367.26327367259;7387.409007279297;7407.148177959603;7408.518446300973;6397.944339183982;7012.859742805013;7362.558246505227;7368.263173682589;7374;5847.26909136358;6781.728730850711;6977.930220697931;7167.605781682058;7213.350798428167;7360.1535823381;7382.52013619113;7386.630668466662;7398.482106252726;7419.962900185465;5264.499872512105;6435.873722098708;6634.469242460688;7231.927680723125;7328.963355183403 03:05:07 INFO - PROCESS | 1668 | |5;yui.html;532.8241680245519;657.5495785387008;710.5949608723029;739.8668239716852;755.5202446446508;14245.358958846851;14462.638434039129;14549.636259093528;14579.833613310937;17293.91353043233;16290.02259864409;16537.586560335967;16545.50363489094;16571.66856662866;16584.917075414607;808.789714674186;960.2653969713175;981.8527220916848;985.9457729824857;991.023841516106;979.6816034788686;990.2078337330144;996.8504724291341;997.5710444508858;999.0409207161134;1038.5067093130779;1046.9738256543571;1048.6696690542492;1052.8473371361185;1055.0820785916226;1033.5504055735778;1040.9219308551812;1043.2540733375636;1045.0855501436242;1048.26621365044;752.1012390193666;752.5259086775296;773.7717373374868;774.4578794843632;778.283978739561;15133.167675777828;15330.923345383313;15364.539063828102;15449.382024718998;15579.766303505343;12984;13008.934955325163;13015.088943773939;13087;13115.344232788322;10215.795684086352;10351.327163734408;10561.894381056169;10685.946570267177;10747.838782418192;3428.8628454862023;3499.4750787382095;3500.422430298998;3509.719222462222;3597.8740744074094;77911.610441948;78667.21332786656;78741;80104.79842802363;80738;7936.6031698414845;9465.053494650618;9584.540292063328;9667.758306042406;9771.902280977241;21862.781372186073;21866.797326147214;21869.562608747736;21892.12431502754;21908.342749717533;7509.51188172778;7556.924430755622;7558.2441755823975;7614.733484328022;7830.451868369273;3841.519810023747;4182.205380977604;4230.217409779139;4233.1322078973735;4260.531341552427;3694.983879433177;3699.963000370016;3724.925501489955;3733.5893051764283;3736.645018723217;684.5618803965466;697.4734075772759;698.3435570563654;703.1316324339437;706.1702499563096;553.2033871225423;600.8918394688998;602.2037885353473;604.3352312456351;631.9273283572448;8268.338532917473;8271.421000529905;8433.114522975;8640.438371505832;8715.172058654418;591.1605520161381;593.6586462783916;630.7413960276265;633.7686744338283;643.1028714942629;3847.153626202231;3977.482927219443;3991.221711766236;4010.578889216649;4207.663386929038;87785.56107219424;89149;93090;93156.53421732847;93766;76679.2332076672;77979.61010194913;78223.60888195522;79067.20932790599;79415;73903.89144162842;75133;75137.24862751411;75825.62087189639;75921.48157036828;8748.91251087481;8834.337424693302;8910.465372077697;8993.730188094107;9011.684591039282;52086.69783255297;52196.73901630467;52259.73870130625;53058;53551.19673204827;51436;67295.32704672891;69302.61394771976;69402;70042;10795.592784400797;11133;11359.204855660024;11434;11646.301221926711;12048.75902481963;12172.817407738714;12203.69490762738;12426.633070362072;12586.307753073668;11704.239224450383;11708.356040417859;11833.230839995373;11988.580399685969;11999.700007499534;11817.409129543661;11828.822567661664;11914.046876250053;11922.344271064827;12114.21257618252;11304.321740695585;11467.655970320904;11523.481443334902;11605.535778568763;12164;9755.024497550188;9866.901330986886;9880.163372780271;9985.051420115078;10214.285000049926;7939.603019848869;9862;9865.06281903218;9963.302568820112;9966.601335946481 03:05:07 INFO - PROCESS | 1668 | __end_tp_report 03:05:07 INFO - PROCESS | 1668 | __start_cc_report 03:05:07 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,360 03:05:07 INFO - PROCESS | 1668 | __end_cc_report 03:05:07 INFO - PROCESS | 1668 | __startTimestamp1458381907885__endTimestamp 03:05:07 INFO - PROCESS | 1668 | 03:05:07 INFO - PROCESS | 1668 | ------- Summary: start ------- 03:05:07 INFO - PROCESS | 1668 | Number of tests: 6 03:05:07 INFO - PROCESS | 1668 | 03:05:07 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5765.61 Median:6023.55 stddev:677.08 (11.2%) stddev-sans-first:655.58 03:05:07 INFO - PROCESS | 1668 | Values: 3507.5 3526.8 3562.9 3569.8 3590.4 5796.8 5808.6 5819.5 5839.8 5851.4 5786.5 5805.6 5812.1 5848.4 5894.3 4047.6 4465.0 4845.9 5206.7 5255.8 4209.9 5258.8 5283.1 5339.8 5344.7 5296.1 5302.0 5307.9 5311.8 5332.3 5294.7 5303.3 5332.9 5348.8 5350.4 4271.3 5048.2 5120.0 5191.2 5224.8 5527.2 5679.5 5679.7 5699.4 5735.1 5301.7 5450.3 6139.6 6312.5 6328.7 6258.8 6263.3 6280.8 6299.4 6314.4 5280.5 5420.4 5989.7 6036.6 6068.4 6263.2 6421.5 6426.5 6483.3 6488.6 6135.3 6241.2 6255.1 6263.0 6286.1 6270.2 6328.6 6329.9 6340.3 6358.2 6145.7 6149.5 6186.5 6203.8 6254.5 6232.3 6232.8 6256.1 6259.2 6260.9 4972.3 5005.2 5009.3 5017.8 5021.9 4390.0 4400.7 4484.5 4499.7 4518.8 5738.3 5872.0 5882.8 5924.8 5940.4 6245.5 6246.2 6283.0 6296.1 6316.0 5628.1 5786.2 5801.0 5810.8 5833.9 5393.1 5411.6 5431.9 5441.7 5455.7 6411.6 6422.2 6422.7 6423.3 6431.4 5211.4 5616.3 5920.0 6223.4 6287.2 6406.4 6410.0 6421.9 6424.7 6518.9 6257.8 6266.3 6266.7 6267.9 6273.5 6229.0 6232.8 6280.2 6289.0 6320.4 5030.7 5870.4 6242.5 6254.8 6258.6 6063.3 6214.6 6234.2 6240.4 6243.6 5987.4 6023.5 6122.2 6132.9 6163.1 6135.5 6210.8 6221.5 6224.6 6236.1 5954.0 6100.8 6108.5 6150.2 6155.3 03:05:07 INFO - PROCESS | 1668 | 03:05:07 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:63654.74 Median:39488.91 stddev:133339.35 (337.7%) stddev-sans-first:133628.99 03:05:07 INFO - PROCESS | 1668 | Values: 460.7 493.3 571.9 576.0 587.3 38932.4 39471.6 39475.8 39487.8 39490.0 33106.8 40361.6 40654.6 40956.2 41169.4 9519.0 9623.0 9698.3 9762.0 9763.4 9420.8 9594.1 9602.3 9625.9 9655.8 7634.0 9516.6 9580.9 9647.6 9703.1 9225.1 9592.9 9595.6 9634.4 9667.0 9605.2 9752.8 9754.1 9774.3 9779.0 39387.2 39983.4 39989.4 40169.2 40350.0 2935.6 3003.6 3295.7 3307.1 3376.1 28789.9 29594.0 29685.9 29897.7 31270.0 2787.3 2811.5 2846.6 2846.7 2929.3 374215.1 406014.0 406505.0 408879.0 411248.9 48142.8 69095.7 69113.6 69542.7 69645.0 46379.5 46888.5 46927.9 47111.5 47152.8 16329.5 16428.8 16641.2 16670.0 16720.9 13034.8 13113.7 13170.1 13218.8 13246.3 15032.5 15287.8 15397.4 15548.5 15619.9 6728.2 6788.4 6821.5 6841.0 6881.1 892.9 959.0 1003.1 1037.8 1044.4 30373.8 30457.8 30926.0 31072.7 31142.0 1106.8 1109.5 1152.4 1153.2 1171.3 14812.5 14825.9 14829.7 14903.0 15028.9 610404.0 612464.0 614699.0 620819.0 624671.0 62242.0 62365.7 63112.7 63146.7 63197.4 1531.0 1551.0 1557.0 1557.9 1663.8 27042.9 28543.3 28986.0 29067.6 29162.7 46503.8 50935.0 51769.7 51839.7 51858.5 455778.0 456049.0 457494.0 457672.0 459800.0 33364.0 45438.1 45742.5 47480.5 47535.8 44715.3 44807.6 45042.0 45382.8 46475.0 31746.8 37451.3 37654.6 38685.0 39481.0 37671.0 37954.6 38113.0 38385.8 38685.8 32501.0 35774.0 37667.6 39121.8 39124.0 31748.5 32479.0 32481.0 32522.5 32769.2 23259.4 24675.5 24902.0 24992.0 25375.2 03:05:07 INFO - PROCESS | 1668 | 03:05:07 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:36329.65 Median:21827.13 stddev:110767.36 (507.5%) stddev-sans-first:111045.18 03:05:07 INFO - PROCESS | 1668 | Values: 366.3 375.2 375.4 376.6 378.6 20268.6 20903.5 21148.8 21851.9 21861.9 20904.9 21120.4 21328.0 21346.6 21392.3 5814.8 5936.1 6009.4 6021.7 6141.2 5292.9 5917.2 6040.9 6068.9 6072.2 5741.6 6010.1 6027.1 6033.2 6048.7 5893.8 5950.2 5954.9 5958.7 5965.8 5097.4 5102.9 5216.1 5230.5 5230.6 26310.6 26973.5 27119.6 27362.2 27487.5 2194.2 2252.2 2336.0 2772.9 2964.2 15145.2 15314.2 15338.0 15506.8 15621.4 1575.4 1746.2 1791.7 1834.7 1860.7 106180.0 107243.5 109031.0 109593.0 111547.9 11181.9 11419.5 11623.2 11638.4 11757.4 14070.6 14102.3 14121.0 14122.2 14124.8 9065.0 9097.0 9206.6 9277.1 9322.5 9533.2 9535.4 9592.9 9649.3 9775.6 5710.0 6299.8 6314.7 6737.6 6847.8 1596.0 1673.4 1921.9 1947.9 1950.4 987.0 1023.9 1033.0 1060.3 1129.7 21802.3 22180.1 22330.8 22653.8 22695.3 1027.5 1050.3 1051.1 1055.0 1085.2 11493.2 11941.5 12134.6 12195.8 12196.7 665230.0 670993.0 671888.0 673556.0 683542.0 96374.0 99295.5 100443.5 103965.0 104000.0 1103.8 1114.0 1124.6 1128.1 1128.8 18944.9 19500.6 19646.8 19815.0 20088.8 48939.0 49742.0 49949.5 50556.7 51282.5 65333.7 68480.7 69377.0 69619.7 69833.6 8235.3 8315.3 8374.6 8512.5 8590.4 13615.5 13640.2 13734.8 13817.6 14173.9 11298.3 11744.4 11958.3 12065.0 12135.5 11688.7 11815.0 11910.2 12092.6 12307.3 11534.2 11800.0 11866.8 12048.6 12133.5 8319.9 8362.7 8415.8 8500.6 8506.9 12025.9 12030.9 12115.4 12188.4 12244.5 03:05:07 INFO - PROCESS | 1668 | 03:05:07 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:6391.01 Median:4912.68 stddev:3367.31 (68.5%) stddev-sans-first:3358.07 03:05:07 INFO - PROCESS | 1668 | Values: 1671.8 1688.5 2007.5 2020.9 2088.9 8471.1 8969.6 9332.0 9549.7 9574.7 9183.0 9230.5 9337.1 9362.2 9368.6 2589.0 2598.0 2600.4 2601.5 2614.4 2542.3 2577.2 2600.3 2616.2 2616.7 2573.4 2592.9 2595.7 2617.8 2620.9 2489.9 2496.6 2517.2 2519.3 2520.0 2560.5 2573.3 2589.3 2595.9 2608.6 9381.3 9436.2 9466.6 9473.1 9516.1 5643.4 5718.7 5720.8 5744.8 5776.6 3734.9 3821.0 3857.7 3862.7 3897.8 1057.3 1065.0 1070.3 1118.3 1123.5 12417.7 12464.6 12497.0 12604.7 12707.2 5008.5 5093.6 5134.8 5207.6 5208.0 10722.9 10743.0 10764.5 10787.0 10832.1 5671.6 5696.8 5725.8 5749.3 5787.5 4123.9 4837.6 4987.8 5046.9 5096.9 4137.4 4164.7 4187.2 4193.1 4225.8 1355.2 1364.9 1375.3 1376.7 1376.7 1386.0 1392.0 1411.4 1438.5 1455.1 7324.0 8539.7 8720.3 8772.9 8801.8 1264.5 1269.5 1272.2 1274.0 1300.7 6520.5 6589.1 6613.1 6652.1 6659.7 9045.3 11472.1 11490.4 11505.4 11527.5 11166.0 11504.4 11596.5 11620.5 11745.8 8798.6 8810.1 8834.2 8865.0 8926.4 8131.2 8238.6 8383.2 8446.4 8471.0 10058.3 10229.3 10258.1 10322.9 10360.7 10391.6 10522.8 10533.3 10608.4 10680.7 6731.8 7190.6 7332.3 7443.6 7571.9 8625.5 8648.8 8681.9 8699.4 8713.1 7510.0 7714.2 7727.8 7767.7 7774.7 7526.9 7548.4 7577.4 7595.2 7738.1 8144.5 8148.8 8198.5 8211.0 8215.7 6246.6 7237.1 7302.2 7320.4 7413.3 7348.5 7423.0 7440.0 7476.4 7490.1 03:05:07 INFO - PROCESS | 1668 | 03:05:07 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:5973.44 Median:6772.56 stddev:1910.26 (28.2%) stddev-sans-first:1866.92 03:05:07 INFO - PROCESS | 1668 | Values: 263.4 312.2 337.7 341.4 341.6 6648.2 6864.9 6902.8 6933.4 7047.2 6815.8 6895.6 6896.7 6905.1 6917.1 4784.4 4945.5 5017.7 5056.3 5071.2 5031.2 5040.6 5042.5 5053.6 5062.4 4995.3 4998.5 5019.5 5023.5 5025.3 5016.0 5019.1 5020.4 5029.7 5032.8 3586.9 4417.2 4432.5 4438.0 4438.7 5377.3 5404.4 6613.7 6650.4 6738.4 5962.3 6019.5 6024.7 6046.2 6100.2 7364.3 7368.3 7369.2 7372.6 7375.1 4082.5 4941.2 4946.8 4956.2 4965.2 6503.9 7353.4 7536.9 7694.0 7820.7 4827.4 4930.6 4985.7 4987.4 4989.2 4208.6 5071.3 5083.9 5087.2 5095.4 5961.8 5964.6 5987.8 6026.8 6042.6 6676.5 6699.4 7353.0 7383.8 7451.1 1717.5 1768.9 1794.1 1797.1 1799.1 996.6 1148.1 1170.6 1171.1 1182.7 6724.0 6767.4 6778.2 6780.4 6828.5 6336.7 7449.8 7566.0 7586.2 7601.0 6777.7 6794.3 6812.9 6822.0 6841.4 3219.9 3876.3 4009.9 4034.9 4035.6 6999.5 7747.8 7875.6 7880.3 7900.4 7816.1 7817.1 7832.8 7840.9 7845.7 7895.6 7981.6 7985.8 7991.2 7991.4 7449.5 7677.8 7709.5 7717.3 7720.0 7489.7 7503.7 7542.5 7546.5 7557.2 7979.9 7996.0 8003.0 8006.4 8022.9 3867.9 4949.7 5049.2 5091.5 5100.3 7345.6 7622.7 7648.8 7672.1 7672.5 7345.6 7367.3 7387.4 7407.1 7408.5 6397.9 7012.9 7362.6 7368.3 7374.0 5847.3 6781.7 6977.9 7167.6 7213.4 7360.2 7382.5 7386.6 7398.5 7420.0 5264.5 6435.9 6634.5 7231.9 7329.0 03:05:07 INFO - PROCESS | 1668 | 03:05:07 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:18610.53 Median:26795.41 stddev:25784.58 (96.2%) stddev-sans-first:25821.18 03:05:07 INFO - PROCESS | 1668 | Values: 532.8 657.5 710.6 739.9 755.5 14245.4 14462.6 14549.6 14579.8 17293.9 16290.0 16537.6 16545.5 16571.7 16584.9 808.8 960.3 981.9 985.9 991.0 979.7 990.2 996.9 997.6 999.0 1038.5 1047.0 1048.7 1052.8 1055.1 1033.6 1040.9 1043.3 1045.1 1048.3 752.1 752.5 773.8 774.5 778.3 15133.2 15330.9 15364.5 15449.4 15579.8 12984.0 13008.9 13015.1 13087.0 13115.3 10215.8 10351.3 10561.9 10685.9 10747.8 3428.9 3499.5 3500.4 3509.7 3597.9 77911.6 78667.2 78741.0 80104.8 80738.0 7936.6 9465.1 9584.5 9667.8 9771.9 21862.8 21866.8 21869.6 21892.1 21908.3 7509.5 7556.9 7558.2 7614.7 7830.5 3841.5 4182.2 4230.2 4233.1 4260.5 3695.0 3700.0 3724.9 3733.6 3736.6 684.6 697.5 698.3 703.1 706.2 553.2 600.9 602.2 604.3 631.9 8268.3 8271.4 8433.1 8640.4 8715.2 591.2 593.7 630.7 633.8 643.1 3847.2 3977.5 3991.2 4010.6 4207.7 87785.6 89149.0 93090.0 93156.5 93766.0 76679.2 77979.6 78223.6 79067.2 79415.0 73903.9 75133.0 75137.2 75825.6 75921.5 8748.9 8834.3 8910.5 8993.7 9011.7 52086.7 52196.7 52259.7 53058.0 53551.2 51436.0 67295.3 69302.6 69402.0 70042.0 10795.6 11133.0 11359.2 11434.0 11646.3 12048.8 12172.8 12203.7 12426.6 12586.3 11704.2 11708.4 11833.2 11988.6 11999.7 11817.4 11828.8 11914.0 11922.3 12114.2 11304.3 11467.7 11523.5 11605.5 12164.0 9755.0 9866.9 9880.2 9985.1 10214.3 7939.6 9862.0 9865.1 9963.3 9966.6 03:05:07 INFO - PROCESS | 1668 | -------- Summary: end -------- 03:05:07 INFO - PROCESS | 1668 | 03:05:08 INFO - TEST-INFO | 1668: exit 0 03:05:08 INFO - TEST-OK | dromaeo_css | took 1111142ms 03:05:08 INFO - TEST-START | kraken 03:05:08 INFO - operating with platform_type : mac_ 03:05:08 INFO - Initialising browser for kraken test... 03:05:08 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmp1Bylls/profile http://localhost:49272/getInfo.html) 03:05:10 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 03:05:10 INFO - PROCESS | 1676 | colorDepth:24 03:05:10 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 03:05:10 INFO - PROCESS | 1676 | __metrics 03:05:10 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:05:11 INFO - TEST-INFO | 1676: exit 0 03:05:11 INFO - Browser initialized. 03:05:11 INFO - Running cycle 1/1 for kraken test... 03:05:11 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmp1Bylls/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:05:23 INFO - PROCESS | 1680 | RSS: Main: 219324416 03:05:23 INFO - PROCESS | 1680 | 03:05:26 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 03:05:26 INFO - PROCESS | 1680 | RSS: Main: 232972288 03:05:26 INFO - PROCESS | 1680 | 03:05:29 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 03:05:29 INFO - PROCESS | 1680 | RSS: Main: 240336896 03:05:29 INFO - PROCESS | 1680 | 03:05:33 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 03:05:33 INFO - PROCESS | 1680 | RSS: Main: 245694464 03:05:33 INFO - PROCESS | 1680 | 03:05:35 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 03:05:36 INFO - PROCESS | 1680 | RSS: Main: 246296576 03:05:36 INFO - PROCESS | 1680 | 03:05:38 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:05:39 INFO - PROCESS | 1680 | RSS: Main: 246865920 03:05:39 INFO - PROCESS | 1680 | 03:05:41 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 03:05:42 INFO - PROCESS | 1680 | RSS: Main: 247001088 03:05:42 INFO - PROCESS | 1680 | 03:05:45 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 03:05:46 INFO - PROCESS | 1680 | RSS: Main: 246804480 03:05:46 INFO - PROCESS | 1680 | 03:05:48 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 03:05:49 INFO - PROCESS | 1680 | RSS: Main: 247226368 03:05:49 INFO - PROCESS | 1680 | 03:05:50 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:05:51 INFO - PROCESS | 1680 | RSS: Main: 248041472 03:05:51 INFO - PROCESS | 1680 | 03:05:53 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:05:53 INFO - PROCESS | 1680 | RSS: Main: 247803904 03:05:53 INFO - PROCESS | 1680 | 03:05:56 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:05:56 INFO - PROCESS | 1680 | RSS: Main: 248311808 03:05:56 INFO - PROCESS | 1680 | 03:05:59 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:05:59 INFO - PROCESS | 1680 | RSS: Main: 247758848 03:05:59 INFO - PROCESS | 1680 | 03:06:02 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:06:03 INFO - PROCESS | 1680 | RSS: Main: 247148544 03:06:03 INFO - PROCESS | 1680 | 03:06:04 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 03:06:05 INFO - PROCESS | 1680 | RSS: Main: 248651776 03:06:05 INFO - PROCESS | 1680 | 03:06:05 INFO - PROCESS | 1680 | __start_tp_report 03:06:05 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 03:06:05 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 03:06:05 INFO - PROCESS | 1680 | |i|pagename|runs| 03:06:05 INFO - PROCESS | 1680 | |0;ai-astar;113;112;115;115;115;129;113;115;116;113 03:06:05 INFO - PROCESS | 1680 | |1;audio-beat-detection;150;120;154;145;119;146;165;119;170;137 03:06:05 INFO - PROCESS | 1680 | |2;audio-dft;194;228;282;208;199;208;197;199;200;208 03:06:05 INFO - PROCESS | 1680 | |3;audio-fft;73;68;71;112;71;79;81;71;121;57 03:06:05 INFO - PROCESS | 1680 | |4;audio-oscillator;84;83;127;77;79;77;115;79;79;118 03:06:05 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;90;88;92;88;90;87;92;88;91;86 03:06:05 INFO - PROCESS | 1680 | |6;imaging-darkroom;95;97;96;95;98;95;96;128;151;139 03:06:05 INFO - PROCESS | 1680 | |7;imaging-desaturate;92;94;91;90;94;89;90;100;91;90 03:06:05 INFO - PROCESS | 1680 | |8;json-parse-financial;53;59;59;56;58;60;60;65;55;55 03:06:05 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;60;63;73;64;70;72;60;68;93;95 03:06:05 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;81;82;84;99;108;106;82;79;82;86 03:06:05 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;128;132;130;129;122;135;153;135;131;134 03:06:05 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;120;159;176;147;175;173;133;150;171;109 03:06:05 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;66;71;76;72;57;88;68;62;79;54 03:06:05 INFO - PROCESS | 1680 | __end_tp_report 03:06:05 INFO - PROCESS | 1680 | __start_cc_report 03:06:05 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,923 03:06:05 INFO - PROCESS | 1680 | __end_cc_report 03:06:05 INFO - PROCESS | 1680 | __startTimestamp1458381965206__endTimestamp 03:06:05 INFO - PROCESS | 1680 | 03:06:05 INFO - PROCESS | 1680 | ------- Summary: start ------- 03:06:05 INFO - PROCESS | 1680 | Number of tests: 14 03:06:05 INFO - PROCESS | 1680 | 03:06:05 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:115.60 Median:115.00 stddev:4.88 (4.2%) stddev-sans-first:5.09 03:06:05 INFO - PROCESS | 1680 | Values: 113.0 112.0 115.0 115.0 115.0 129.0 113.0 115.0 116.0 113.0 03:06:05 INFO - PROCESS | 1680 | 03:06:05 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:148.00 stddev:18.59 (12.6%) stddev-sans-first:19.52 03:06:05 INFO - PROCESS | 1680 | Values: 150.0 120.0 154.0 145.0 119.0 146.0 165.0 119.0 170.0 137.0 03:06:05 INFO - PROCESS | 1680 | 03:06:05 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:212.30 Median:208.00 stddev:26.32 (12.7%) stddev-sans-first:27.07 03:06:05 INFO - PROCESS | 1680 | Values: 194.0 228.0 282.0 208.0 199.0 208.0 197.0 199.0 200.0 208.0 03:06:05 INFO - PROCESS | 1680 | 03:06:05 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:80.40 Median:71.00 stddev:20.19 (28.4%) stddev-sans-first:21.24 03:06:05 INFO - PROCESS | 1680 | Values: 73.0 68.0 71.0 112.0 71.0 79.0 81.0 71.0 121.0 57.0 03:06:05 INFO - PROCESS | 1680 | 03:06:05 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:79.00 stddev:19.81 (25.1%) stddev-sans-first:20.81 03:06:05 INFO - PROCESS | 1680 | Values: 84.0 83.0 127.0 77.0 79.0 77.0 115.0 79.0 79.0 118.0 03:06:05 INFO - PROCESS | 1680 | 03:06:05 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:89.20 Median:90.00 stddev:2.10 (2.3%) stddev-sans-first:2.20 03:06:05 INFO - PROCESS | 1680 | Values: 90.0 88.0 92.0 88.0 90.0 87.0 92.0 88.0 91.0 86.0 03:06:05 INFO - PROCESS | 1680 | 03:06:05 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:109.00 Median:95.50 stddev:21.64 (22.7%) stddev-sans-first:22.36 03:06:05 INFO - PROCESS | 1680 | Values: 95.0 97.0 96.0 95.0 98.0 95.0 96.0 128.0 151.0 139.0 03:06:05 INFO - PROCESS | 1680 | 03:06:05 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:92.10 Median:91.00 stddev:3.25 (3.6%) stddev-sans-first:3.44 03:06:05 INFO - PROCESS | 1680 | Values: 92.0 94.0 91.0 90.0 94.0 89.0 90.0 100.0 91.0 90.0 03:06:05 INFO - PROCESS | 1680 | 03:06:05 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:59.00 stddev:3.43 (5.8%) stddev-sans-first:3.13 03:06:05 INFO - PROCESS | 1680 | Values: 53.0 59.0 59.0 56.0 58.0 60.0 60.0 65.0 55.0 55.0 03:06:05 INFO - PROCESS | 1680 | 03:06:05 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:71.00 stddev:12.58 (17.7%) stddev-sans-first:12.59 03:06:05 INFO - PROCESS | 1680 | Values: 60.0 63.0 73.0 64.0 70.0 72.0 60.0 68.0 93.0 95.0 03:06:05 INFO - PROCESS | 1680 | 03:06:05 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:82.00 stddev:11.03 (13.5%) stddev-sans-first:11.32 03:06:05 INFO - PROCESS | 1680 | Values: 81.0 82.0 84.0 99.0 108.0 106.0 82.0 79.0 82.0 86.0 03:06:05 INFO - PROCESS | 1680 | 03:06:05 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:132.90 Median:133.00 stddev:8.06 (6.1%) stddev-sans-first:8.35 03:06:05 INFO - PROCESS | 1680 | Values: 128.0 132.0 130.0 129.0 122.0 135.0 153.0 135.0 131.0 134.0 03:06:05 INFO - PROCESS | 1680 | 03:06:05 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.30 Median:165.00 stddev:24.07 (14.6%) stddev-sans-first:22.71 03:06:05 INFO - PROCESS | 1680 | Values: 120.0 159.0 176.0 147.0 175.0 173.0 133.0 150.0 171.0 109.0 03:06:05 INFO - PROCESS | 1680 | 03:06:05 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:71.50 stddev:10.27 (14.4%) stddev-sans-first:10.83 03:06:05 INFO - PROCESS | 1680 | Values: 66.0 71.0 76.0 72.0 57.0 88.0 68.0 62.0 79.0 54.0 03:06:05 INFO - PROCESS | 1680 | -------- Summary: end -------- 03:06:05 INFO - PROCESS | 1680 | 03:06:05 INFO - TEST-INFO | 1680: exit 0 03:06:05 INFO - TEST-OK | kraken | took 57619ms 03:06:05 INFO - SUITE-END | took 1168s 03:06:06 INFO - Completed test suite (00:19:29) 03:06:06 INFO - javascript benchmark 03:06:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3507.473878918162, 3526.841292141854, 3562.946555801665, 3569.750117491775, 3590.407582748845, 5796.797112101067, 5808.647497763402, 5819.476247137757, 5839.824805255838, 5851.356350801409, 5786.450287222718, 5805.5936084474, 5812.1281807728865, 5848.444397782215, 5894.322152952412, 4047.6154765297397, 4464.97767511162, 4845.885446347343, 5206.687598744078, 5255.816046438375, 4209.873703788891, 5258.763355648985, 5283.07546179419, 5339.759710813023, 5344.679319240839, 5296.126139187029, 5302.0, 5307.946920530803, 5311.787528498855, 5332.280142180794, 5294.735263236823, 5303.257543943851, 5332.92000619991, 5348.839534813942, 5350.411454739976, 4271.252530807096, 5048.192289233742, 5120.0, 5191.169412893919, 5224.813381737054, 5527.198556209368, 5679.488846003879, 5679.7160141993145, 5699.373068962411, 5735.139729040678, 5301.73491325436, 5450.264214331054, 6139.631622102688, 6312.52656050798, 6328.65192414417, 6258.843528911768, 6263.31103578606, 6280.842978925518, 6299.401556852137, 6314.400131987454, 5280.498352656491, 5420.430854760233, 5989.700514974277, 6036.577439579275, 6068.362821903636, 6263.248410190807, 6421.486281097501, 6426.485881129498, 6483.3192514786215, 6488.578242414228, 6135.324535308531, 6241.21984751906, 6255.12428260044, 6263.0, 6286.057091436322, 6270.216222972129, 6328.557001009977, 6329.873402531924, 6340.270868850049, 6358.1734374531015, 6145.740123274718, 6149.477294430024, 6186.4741496973265, 6203.7828675996125, 6254.530910181664, 6232.25212974446, 6232.750689972441, 6256.061590761422, 6259.155014073133, 6260.937390626126, 4972.303877457159, 5005.249212618136, 5009.348784658044, 5017.84946451607, 5021.94539146776, 4389.956100438954, 4400.713953593006, 4484.529124441952, 4499.662525310615, 4518.751468669189, 5738.282714660668, 5871.970640146772, 5882.823515294548, 5924.822255332347, 5940.376260492672, 6245.469135123474, 6246.187995560548, 6282.968585157045, 6296.087067375205, 6315.968420157962, 5628.127640215773, 5786.2477877876445, 5801.042827933428, 5810.796622118206, 5833.88332233353, 5393.110136827379, 5411.56707463402, 5431.864203394946, 5441.700706461103, 5455.699936503531, 6411.647359395278, 6422.197225346832, 6422.710978005907, 6423.293437721847, 6431.389018043278, 5211.400688920671, 5616.326040875121, 5919.964006298795, 6223.408776166257, 6287.1512345832725, 6406.359364063556, 6409.9679501602195, 6421.903671444838, 6424.678766061772, 6518.934810651833, 6257.843553911189, 6266.279377871603, 6266.749330026748, 6267.934451143407, 6273.52948528853, 6228.9722195838995, 6232.781852635136, 6280.183576135073, 6289.0, 6320.4311611955145, 5030.698158110378, 5870.412958704095, 6242.500599951902, 6254.8123556293385, 6258.593191442542, 6063.272407310975, 6214.627122372672, 6234.1583886174785, 6240.438360547391, 6243.562950593415, 5987.401259873977, 6023.548233882389, 6122.184701511214, 6132.936844521141, 6163.137160797402, 6135.478484328703, 6210.844728881814, 6221.502279817513, 6224.564280500322, 6236.064590311489, 5953.970230148995, 6100.816975490742, 6108.541859360477, 6150.169727086786, 6155.2613686356135], "unit": "score", "name": "dojo.html", "value": 5723.859296216929}, {"lowerIsBetter": false, "replicates": [460.67292222521985, 493.3044407385587, 571.8734093835146, 575.9805144893538, 587.3187102960567, 38932.41601375978, 39471.60528394715, 39475.80262098689, 39487.815365539005, 39490.01274968127, 33106.8344658277, 40361.59638403615, 40654.59345406545, 40956.18087638253, 41169.382459263135, 9518.952405237982, 9623.03769623039, 9698.321117521777, 9762.0, 9763.414195148278, 9420.81158376832, 9594.136527712504, 9602.279829012818, 9625.855612165788, 9655.75860603487, 7634.00757901472, 9516.572514122869, 9580.856287155699, 9647.565859536302, 9703.07820757027, 9225.12361325673, 9592.90407095927, 9595.568199431042, 9634.373765705206, 9666.951665241699, 9605.231581473465, 9752.804943901083, 9754.0733630305, 9774.26692998021, 9779.022097790235, 39387.21225575501, 39983.40024899629, 39989.40015899764, 40169.196616067806, 40350.0, 2935.5743417204385, 3003.594514740526, 3295.736341092731, 3307.074019274607, 3376.1053320869987, 28789.856050719613, 29593.964211252503, 29685.851570742223, 29897.701022989928, 31270.0, 2787.317107308702, 2811.4939310924024, 2846.6299381080325, 2846.6584009918943, 2929.282325830185, 374215.12892435637, 406014.0, 406504.9674751637, 408879.0, 411248.8875111241, 48142.75928620334, 69095.65452172708, 69113.61772764516, 69542.65228673824, 69645.0, 46379.5362046382, 46888.531114689096, 46927.949683270475, 47111.5288847114, 47152.76423617928, 16329.510114696579, 16428.835711642732, 16641.167941603115, 16670.0, 16720.913140646062, 13034.784086705284, 13113.672158196121, 13170.143940643828, 13218.801717974238, 13246.271455070064, 15032.549023529311, 15287.847121528865, 15397.384104635688, 15548.455804046804, 15619.921900390653, 6728.158980127484, 6788.422984046312, 6821.488388370793, 6841.0, 6881.13985751781, 892.9329451305628, 958.9520523973773, 1003.1072345612411, 1037.7976294622476, 1044.4307852220406, 30373.848130759205, 30457.847710761303, 30926.0, 31072.68927310698, 31142.0, 1106.778644271149, 1109.5062697099713, 1152.4007516091585, 1153.1697178031804, 1171.2562522797914, 14812.481563145238, 14825.92587037058, 14829.703405932038, 14903.0, 15028.924855375653, 610404.0, 612464.0, 614699.0, 620819.0, 624671.0, 62242.0, 62365.68817155976, 63112.737745244835, 63146.68426657837, 63197.368026320066, 1530.9770353444708, 1550.968980620404, 1557.0424189123607, 1557.8520040596125, 1663.8003439587085, 27042.864785675945, 28543.28641783972, 28985.98549050773, 29067.563986539797, 29162.708372916, 46503.83740406517, 50935.0, 51769.741151294, 51839.74080129575, 51858.481415185364, 455778.0, 456049.0, 457494.0, 457672.0, 459800.0, 33364.0, 45438.091238175715, 45742.542574573825, 47480.52519474761, 47535.76232118817, 44715.32927006163, 44807.55192448164, 45042.0, 45382.77308613436, 46475.0, 31746.841265794446, 37451.30248785263, 37654.62345376511, 38685.0, 39481.0, 37671.0, 37954.620453795105, 38113.0, 38385.808070960586, 38685.80657096697, 32501.02496925096, 35774.0, 37667.623323767504, 39121.804390977864, 39124.0, 31748.523772143897, 32479.0, 32481.0, 32522.51216231711, 32769.180770480925, 23259.418514536595, 24675.506489869742, 24902.007839372443, 24992.000319987725, 25375.238742837744], "unit": "score", "name": "ext.html", "value": 19616.92139539091}, {"lowerIsBetter": false, "replicates": [366.2857428015371, 375.19895024123497, 375.37125315097217, 376.553783766237, 378.62516109052046, 20268.59462810743, 20903.477413064662, 21148.836813975224, 21851.907404629783, 21861.890690546526, 20904.8954755226, 21120.366389008315, 21327.97384248494, 21346.57306853862, 21392.25127120551, 5814.767409303623, 5936.139259807325, 6009.399060093978, 6021.729022194012, 6141.17094192285, 5292.947070529303, 5917.171595976567, 6040.939590604104, 6068.939310606882, 6072.180255665473, 5741.626794258381, 6010.098485227207, 6027.065804800263, 6033.190042987108, 6048.667323297217, 5893.764249430018, 5950.226470558843, 5954.851128721773, 5958.731857066421, 5965.761369545213, 5097.413797413271, 5102.872428189325, 5216.087184742692, 5230.529252367305, 5230.555402790729, 26310.6053409199, 26973.46053078947, 27119.593206101923, 27362.179134625992, 27487.45025099487, 2194.221051526701, 2252.1554417093425, 2336.0188720737333, 2772.861356932145, 2964.1996660901436, 15145.167015814126, 15314.234288285541, 15338.003029803027, 15506.844931550653, 15621.375144994186, 1575.4249698859949, 1746.1880225694986, 1791.6506281275156, 1834.6972749496317, 1860.748798912143, 106180.0, 107243.46378268137, 109030.9999999992, 109593.0, 111547.88452115456, 11181.944090279496, 11419.543218271176, 11623.186376953532, 11638.359890205951, 11757.412129393497, 14070.577882663536, 14102.294885255902, 14121.0, 14122.152670839783, 14124.788128178085, 9065.0, 9096.954515227382, 9206.585703643352, 9277.118673725985, 9322.533873306307, 9533.189678877234, 9535.427874327563, 9592.853324273461, 9649.276304277208, 9775.560099795526, 5710.029295019856, 6299.779507717208, 6314.652694101868, 6737.59574425536, 6847.760328388582, 1595.968080638404, 1673.4226691791312, 1921.8654694171553, 1947.9220831166879, 1950.3953774330002, 986.9538289413244, 1023.8566600675912, 1032.9741756455999, 1060.2525219720078, 1129.728865072393, 21802.345929622137, 22180.112795488323, 22330.776692233194, 22653.773462265497, 22695.319140425814, 1027.5119318323736, 1050.3330385205297, 1051.1380667852288, 1054.9947250263854, 1085.1752667972398, 11493.195476316578, 11941.52233910634, 12134.575289864812, 12195.817062744067, 12196.695082623006, 665230.0, 670993.0, 671888.0, 673556.0, 683542.0, 96374.0, 99295.51056734155, 100443.49778251062, 103965.0, 104000.0, 1103.757173421846, 1114.0363585498646, 1124.5558004588142, 1128.1200663482496, 1128.836318733779, 18944.905275473535, 19500.60998780045, 19646.80353196507, 19815.0, 20088.79911200869, 48939.0, 49742.0, 49949.50050499449, 50556.747216263684, 51282.48717512927, 65333.69332613226, 68480.65759671369, 69377.0, 69619.65190174017, 69833.60332793214, 8235.34117270605, 8315.251627353568, 8374.623141958748, 8512.531810750468, 8590.398672092893, 13615.52345667897, 13640.181589104686, 13734.793978090536, 13817.577320100785, 14173.929130354281, 11298.265612735146, 11744.412779361168, 11958.282503049844, 12065.034797216025, 12135.453904574491, 11688.70778230551, 11814.99572536344, 11910.225835320676, 12092.637220883387, 12307.26156430617, 11534.192606517463, 11800.0, 11866.76266474683, 12048.578299759467, 12133.514659413524, 8319.916800831914, 8362.665493380196, 8415.831683366421, 8500.6232859636, 8506.914930850613, 12025.939870300592, 12030.939845301067, 12115.394230288626, 12188.390580471118, 12244.510219591117], "unit": "score", "name": "jquery.html", "value": 10025.67945711225}, {"lowerIsBetter": false, "replicates": [1671.8411750883665, 1688.5440930948644, 2007.548301632133, 2020.8787472751635, 2088.872009115078, 8471.110533393998, 8969.55152242387, 9331.953340233298, 9549.713508594754, 9574.712758617245, 9182.954085229581, 9230.492322922237, 9337.066293370677, 9362.204212641916, 9368.625254989793, 2588.961165582513, 2597.9610305845426, 2600.401907561262, 2601.479704059186, 2614.398688301692, 2542.275451496324, 2577.226831950417, 2600.2979195617268, 2616.2020583721956, 2616.699079605851, 2573.395252115751, 2592.93517662059, 2595.6625638666947, 2617.8429294242405, 2620.89516419343, 2489.8879550420183, 2496.6379874918125, 2517.2196619048154, 2519.3323769201174, 2520.0171932946164, 2560.5263026340185, 2573.266619013572, 2589.3138318345655, 2595.883185256668, 2608.608708693711, 9381.343305968585, 9436.245100392021, 9466.574004169828, 9473.05269473054, 9516.095970882825, 5643.351014633287, 5718.656880587178, 5720.799772008001, 5744.798932037401, 5776.566757493205, 3734.925301493955, 3820.9617903820886, 3857.6720978716844, 3862.671672907806, 3897.80510974453, 1057.2546354819833, 1064.9520771565221, 1070.2936062198912, 1118.3122379736485, 1123.5056575107008, 12417.689557761038, 12464.626061218178, 12497.00023998078, 12604.684882878002, 12707.237565746085, 5008.474110218447, 5093.617978651616, 5134.768935397916, 5207.609429292818, 5208.0365132450615, 10722.946385268024, 10743.0, 10764.515596798163, 10787.0, 10832.079273261861, 5671.574631902624, 5696.800611978644, 5725.77096916127, 5749.281339832521, 5787.479126878601, 4123.9175216496105, 4837.588804951548, 4987.775550100254, 5046.949530504721, 5096.898062038738, 4137.40007698882, 4164.708470407103, 4187.225363307798, 4193.1194449165405, 4225.7887105644595, 1355.2478374502048, 1364.8908087352988, 1375.326090215807, 1376.6971266321593, 1376.745302119111, 1386.0367044903694, 1392.046448182998, 1411.4213172599184, 1438.4893362856244, 1455.1269238456841, 7323.963380183065, 8539.74380768578, 8720.30237580992, 8772.859528261286, 8801.779955501035, 1264.5131624324517, 1269.504893091695, 1272.179444258448, 1274.0444666500125, 1300.6878349196313, 6520.47836173105, 6589.077529145923, 6613.107230523914, 6652.06871038055, 6659.733610655617, 9045.321600879828, 11472.082233421306, 11490.368029758443, 11505.367204803648, 11527.48126334317, 11166.0, 11504.36725980079, 11596.492455980668, 11620.535178592761, 11745.823812642817, 8798.648054077765, 8810.118988101267, 8834.249088827393, 8865.0, 8926.419782714103, 8131.186881311822, 8238.629261683118, 8383.161683831568, 8446.36652251096, 8471.025832029396, 10058.295919285873, 10229.335093218917, 10258.076773090159, 10322.948385258325, 10360.689179324632, 10391.636292729718, 10522.789544209227, 10533.262671612914, 10608.416537090534, 10680.679579612624, 6731.764388246388, 7190.604516751629, 7332.340089391981, 7443.55338679681, 7571.886421703789, 8625.482471051757, 8648.827023459622, 8681.8697719533, 8699.391042627209, 8713.085126061673, 7509.9624501879325, 7714.190010048864, 7727.806804829925, 7767.689292428239, 7774.727884524014, 7526.924730752622, 7548.396128309612, 7577.431692622965, 7595.164531901376, 7738.148803631709, 8144.511329320259, 8148.755537333889, 8198.549079800669, 8211.0, 8215.712450064459, 6246.562740608296, 7237.131544214728, 7302.160251571137, 7320.377767889789, 7413.2957369049855, 7348.485606007528, 7422.96288518554, 7440.0, 7476.364509016795, 7490.1386340571535], "unit": "score", "name": "mootools.html", "value": 5230.372509564624}, {"lowerIsBetter": false, "replicates": [263.3666033190178, 312.20699423464396, 337.70619560981964, 341.41447417678677, 341.62762588778236, 6648.238216872526, 6864.931350686492, 6902.792916212522, 6933.405316777144, 7047.1895731990835, 6815.795526134211, 6895.586264824114, 6896.724131034753, 6905.136857892763, 6917.100776898996, 4784.354112194861, 4945.480724523927, 5017.67385119966, 5056.317397151374, 5071.1886098224295, 5031.245313203012, 5040.621953353495, 5042.47054059324, 5053.5957123430035, 5062.367204099488, 4995.325631039817, 4998.475160108191, 5019.52314530119, 5023.547880690737, 5025.341637259714, 5016.021875734234, 5019.096562618727, 5020.447750747415, 5029.723365214912, 5032.849014529534, 3586.9282614347826, 4417.204903117437, 4432.468103827529, 4437.955620443787, 4438.667099967483, 5377.327834020747, 5404.405515393303, 6613.735450581971, 6650.434713049397, 6738.427233685143, 5962.34414214436, 6019.488343490809, 6024.698765061729, 6046.183765191687, 6100.176476175704, 7364.263573642646, 7368.336849683501, 7369.22623124575, 7372.557646541225, 7375.114986201636, 4082.4692789937417, 4941.160002799496, 4946.752662366904, 4956.1822299320565, 4965.205567109281, 6503.869922601569, 7353.448491363116, 7536.924630753677, 7693.9615301923695, 7820.687172513092, 4827.42070951488, 4930.580900623487, 4985.700857948535, 4987.351644286219, 4989.201727723546, 4208.558101399309, 5071.264666623319, 5083.898322033612, 5087.186050232019, 5095.439501654815, 5961.821145365646, 5964.642121472725, 5987.760489580455, 6026.789062382795, 6042.637441753509, 6676.499262555328, 6699.43054840344, 7353.0441042664115, 7383.8154046149275, 7451.068616422947, 1717.5105095047852, 1768.8761786674809, 1794.0760508338217, 1797.1014492753623, 1799.064486467056, 996.6196817407942, 1148.1102145837044, 1170.607846371458, 1171.1392126786805, 1182.7338848758961, 6724.0, 6767.39093481589, 6778.186617605918, 6780.440498685231, 6828.487863410264, 6336.714847831859, 7449.813754656068, 7565.962170189224, 7586.165521792598, 7601.0, 6777.728890844311, 6794.252632210453, 6812.863742725217, 6821.953413975787, 6841.418479429205, 3219.935601287961, 3876.2828876657345, 4009.917322323015, 4034.8500677307416, 4035.576264492186, 6999.545029573062, 7747.806304842311, 7875.56684382353, 7880.330171935335, 7900.367970562341, 7816.062072551216, 7817.101033381234, 7832.765017049498, 7840.9215907841335, 7845.686172553148, 7895.565743884026, 7981.561014144278, 7985.800354991172, 7991.200879912079, 7991.440599158003, 7449.515781474187, 7677.808054798675, 7709.537427754352, 7717.2668596483245, 7720.0, 7489.70041198346, 7503.699852006077, 7542.509736867086, 7546.547207167588, 7557.168711441627, 7979.880301795594, 7995.960020199862, 8002.999625046869, 8006.399520036137, 8022.879656805269, 3867.8839634811, 4949.737816856678, 5049.217371307306, 5091.465396133352, 5100.336956195671, 7345.595992220479, 7622.656980436004, 7648.80877978055, 7672.117706463605, 7672.5012874163, 7345.55926644403, 7367.26327367259, 7387.409007279297, 7407.148177959603, 7408.518446300973, 6397.944339183982, 7012.859742805013, 7362.558246505227, 7368.263173682589, 7374.0, 5847.26909136358, 6781.728730850711, 6977.930220697931, 7167.605781682058, 7213.350798428167, 7360.1535823381, 7382.52013619113, 7386.630668466662, 7398.482106252726, 7419.962900185465, 5264.499872512105, 6435.873722098708, 6634.469242460688, 7231.927680723125, 7328.963355183403], "unit": "score", "name": "prototype.html", "value": 5333.560228948319}, {"lowerIsBetter": false, "replicates": [532.8241680245519, 657.5495785387008, 710.5949608723029, 739.8668239716852, 755.5202446446508, 14245.358958846851, 14462.638434039129, 14549.636259093528, 14579.833613310937, 17293.91353043233, 16290.02259864409, 16537.586560335967, 16545.50363489094, 16571.66856662866, 16584.917075414607, 808.789714674186, 960.2653969713175, 981.8527220916848, 985.9457729824857, 991.023841516106, 979.6816034788686, 990.2078337330144, 996.8504724291341, 997.5710444508858, 999.0409207161134, 1038.5067093130779, 1046.9738256543571, 1048.6696690542492, 1052.8473371361185, 1055.0820785916226, 1033.5504055735778, 1040.9219308551812, 1043.2540733375636, 1045.0855501436242, 1048.26621365044, 752.1012390193666, 752.5259086775296, 773.7717373374868, 774.4578794843632, 778.283978739561, 15133.167675777828, 15330.923345383313, 15364.539063828102, 15449.382024718998, 15579.766303505343, 12984.0, 13008.934955325163, 13015.088943773939, 13087.0, 13115.344232788322, 10215.795684086352, 10351.327163734408, 10561.894381056169, 10685.946570267177, 10747.838782418192, 3428.8628454862023, 3499.4750787382095, 3500.422430298998, 3509.719222462222, 3597.8740744074094, 77911.610441948, 78667.21332786656, 78741.0, 80104.79842802363, 80738.0, 7936.6031698414845, 9465.053494650618, 9584.540292063328, 9667.758306042406, 9771.902280977241, 21862.781372186073, 21866.797326147214, 21869.562608747736, 21892.12431502754, 21908.342749717533, 7509.51188172778, 7556.924430755622, 7558.2441755823975, 7614.733484328022, 7830.451868369273, 3841.519810023747, 4182.205380977604, 4230.217409779139, 4233.1322078973735, 4260.531341552427, 3694.983879433177, 3699.963000370016, 3724.925501489955, 3733.5893051764283, 3736.645018723217, 684.5618803965466, 697.4734075772759, 698.3435570563654, 703.1316324339437, 706.1702499563096, 553.2033871225423, 600.8918394688998, 602.2037885353473, 604.3352312456351, 631.9273283572448, 8268.338532917473, 8271.421000529905, 8433.114522975, 8640.438371505832, 8715.172058654418, 591.1605520161381, 593.6586462783916, 630.7413960276265, 633.7686744338283, 643.1028714942629, 3847.153626202231, 3977.482927219443, 3991.221711766236, 4010.578889216649, 4207.663386929038, 87785.56107219424, 89149.0, 93090.0, 93156.53421732847, 93766.0, 76679.2332076672, 77979.61010194913, 78223.60888195522, 79067.20932790599, 79415.0, 73903.89144162842, 75133.0, 75137.24862751411, 75825.62087189639, 75921.48157036828, 8748.91251087481, 8834.337424693302, 8910.465372077697, 8993.730188094107, 9011.684591039282, 52086.69783255297, 52196.73901630467, 52259.73870130625, 53058.0, 53551.19673204827, 51436.0, 67295.32704672891, 69302.61394771976, 69402.0, 70042.0, 10795.592784400797, 11133.0, 11359.204855660024, 11434.0, 11646.301221926711, 12048.75902481963, 12172.817407738714, 12203.69490762738, 12426.633070362072, 12586.307753073668, 11704.239224450383, 11708.356040417859, 11833.230839995373, 11988.580399685969, 11999.700007499534, 11817.409129543661, 11828.822567661664, 11914.046876250053, 11922.344271064827, 12114.21257618252, 11304.321740695585, 11467.655970320904, 11523.481443334902, 11605.535778568763, 12164.0, 9755.024497550188, 9866.901330986886, 9880.163372780271, 9985.051420115078, 10214.285000049926, 7939.603019848869, 9862.0, 9865.06281903218, 9963.302568820112, 9966.601335946481], "unit": "score", "name": "yui.html", "value": 7153.977044279585}], "name": "dromaeo_css", "value": 7796.994214667688}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 112.0, 115.0, 115.0, 115.0, 129.0, 113.0, 115.0, 116.0, 113.0], "unit": "score", "name": "ai-astar", "value": 115.6}, {"lowerIsBetter": true, "replicates": [150.0, 120.0, 154.0, 145.0, 119.0, 146.0, 165.0, 119.0, 170.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 142.5}, {"lowerIsBetter": true, "replicates": [194.0, 228.0, 282.0, 208.0, 199.0, 208.0, 197.0, 199.0, 200.0, 208.0], "unit": "score", "name": "audio-dft", "value": 212.3}, {"lowerIsBetter": true, "replicates": [73.0, 68.0, 71.0, 112.0, 71.0, 79.0, 81.0, 71.0, 121.0, 57.0], "unit": "score", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 127.0, 77.0, 79.0, 77.0, 115.0, 79.0, 79.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 91.8}, {"lowerIsBetter": true, "replicates": [90.0, 88.0, 92.0, 88.0, 90.0, 87.0, 92.0, 88.0, 91.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 89.2}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 96.0, 95.0, 98.0, 95.0, 96.0, 128.0, 151.0, 139.0], "unit": "score", "name": "imaging-darkroom", "value": 109.0}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 91.0, 90.0, 94.0, 89.0, 90.0, 100.0, 91.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 92.1}, {"lowerIsBetter": true, "replicates": [53.0, 59.0, 59.0, 56.0, 58.0, 60.0, 60.0, 65.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [60.0, 63.0, 73.0, 64.0, 70.0, 72.0, 60.0, 68.0, 93.0, 95.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.8}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 84.0, 99.0, 108.0, 106.0, 82.0, 79.0, 82.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.9}, {"lowerIsBetter": true, "replicates": [128.0, 132.0, 130.0, 129.0, 122.0, 135.0, 153.0, 135.0, 131.0, 134.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 132.9}, {"lowerIsBetter": true, "replicates": [120.0, 159.0, 176.0, 147.0, 175.0, 173.0, 133.0, 150.0, 171.0, 109.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.3}, {"lowerIsBetter": true, "replicates": [66.0, 71.0, 76.0, 72.0, 57.0, 88.0, 68.0, 62.0, 79.0, 54.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1505.1000000000001}]} 03:06:06 INFO - Return code: 0 03:06:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:06:06 ERROR - # TBPL SUCCESS # 03:06:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:06:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:06:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:06:06 INFO - 2016-03-19 03:06:06.550 screenresolution[1689:10627] starting screenresolution argv=screenresolution get 03:06:06 INFO - 2016-03-19 03:06:06.553 screenresolution[1689:10627] Display 0: 1600x1200x32@60 03:06:06 INFO - 2016-03-19 03:06:06.559 screenresolution[1690:10629] starting screenresolution argv=screenresolution list 03:06:06 INFO - Available Modes on Display 0 03:06:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:06:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:06:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:06:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:06:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:06:06 INFO - Intel Iris: 03:06:06 INFO - Chipset Model: Intel Iris 03:06:06 INFO - Type: GPU 03:06:06 INFO - Bus: Built-In 03:06:06 INFO - VRAM (Dynamic, Max): 1536 MB 03:06:06 INFO - Vendor: Intel (0x8086) 03:06:06 INFO - Device ID: 0x0a2e 03:06:06 INFO - Revision ID: 0x0009 03:06:06 INFO - Displays: 03:06:06 INFO - Display: 03:06:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:06:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:06:06 INFO - Display Serial Number: 1600x1200 60 03:06:06 INFO - Main Display: Yes 03:06:06 INFO - Mirror: Off 03:06:06 INFO - Online: Yes 03:06:06 INFO - Rotation: Supported 03:06:06 INFO - Return code: 0 03:06:06 INFO - Running post-action listener: _resource_record_post_action 03:06:06 INFO - Running post-run listener: _resource_record_post_run 03:06:07 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 37533184; Write bytes: 665033216; Read time: 430; Write time: 2371 03:06:07 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 355967488; Write bytes: 352454144; Read time: 28032; Write time: 595 03:06:07 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 35743232; Write bytes: 301405184; Read time: 375; Write time: 1744 03:06:07 INFO - Running post-run listener: _upload_blobber_files 03:06:07 INFO - Blob upload gear active. 03:06:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:06:07 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 03:06:07 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'] 03:06:07 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 03:06:08 INFO - (blobuploader) - INFO - Open directory for files ... 03:06:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:06:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:06:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:09 INFO - (blobuploader) - INFO - Done attempting. 03:06:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:06:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:06:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:10 INFO - (blobuploader) - INFO - Done attempting. 03:06:10 INFO - (blobuploader) - INFO - Iteration through files over. 03:06:10 INFO - Return code: 0 03:06:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:06:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:06:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4a067c1204d779250b1de0e2602077d84764cd0e3c0f66432a08c5ba546e440ba5e8efdfd328ea47170439a0adf0924840ce54c51d1736db9691e7d66f4740e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f98997bb395a3705bfc46df5bfb141a92ed28f32d817e19c0516f8304fdbdb2e3724f2ec015c20e427fc7492e3f411f2dffc2415c359f84f9227cb7187cf7798"} 03:06:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:06:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:06:10 INFO - Contents: 03:06:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4a067c1204d779250b1de0e2602077d84764cd0e3c0f66432a08c5ba546e440ba5e8efdfd328ea47170439a0adf0924840ce54c51d1736db9691e7d66f4740e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f98997bb395a3705bfc46df5bfb141a92ed28f32d817e19c0516f8304fdbdb2e3724f2ec015c20e427fc7492e3f411f2dffc2415c359f84f9227cb7187cf7798"} 03:06:10 INFO - Running post-run listener: copy_logs_to_upload_dir 03:06:10 INFO - Copying logs to upload dir... 03:06:10 INFO - mkdir: /builds/slave/test/build/upload/logs 03:06:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.496195 ========= master_lag: 12.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-03-19 03:06:22.575330) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-19 03:06:22.579178) ========= 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.9yMun4gGIB/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.ynVyBprsik/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4a067c1204d779250b1de0e2602077d84764cd0e3c0f66432a08c5ba546e440ba5e8efdfd328ea47170439a0adf0924840ce54c51d1736db9691e7d66f4740e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f98997bb395a3705bfc46df5bfb141a92ed28f32d817e19c0516f8304fdbdb2e3724f2ec015c20e427fc7492e3f411f2dffc2415c359f84f9227cb7187cf7798"} build_url:https://queue.taskcluster.net/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011178 build_url: 'https://queue.taskcluster.net/v1/task/cbxj1ba5S9yfa5QVHqJQFw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4a067c1204d779250b1de0e2602077d84764cd0e3c0f66432a08c5ba546e440ba5e8efdfd328ea47170439a0adf0924840ce54c51d1736db9691e7d66f4740e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f98997bb395a3705bfc46df5bfb141a92ed28f32d817e19c0516f8304fdbdb2e3724f2ec015c20e427fc7492e3f411f2dffc2415c359f84f9227cb7187cf7798"}' ========= master_lag: 0.85 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-19 03:06:23.435716) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 03:06:23.436023) ========= 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.9yMun4gGIB/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.ynVyBprsik/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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.005228 ========= master_lag: 0.32 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 03:06:23.762345) ========= ========= Started reboot skipped (results: 3, elapsed: 4 secs) (at 2016-03-19 03:06:23.762614) ========= ========= Finished reboot skipped (results: 3, elapsed: 4 secs) (at 2016-03-19 03:06:28.222268) ========= ========= Total master_lag: 13.56 =========