builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0067 starttime: 1460222181.67 results: success (0) buildid: 20160409084734 builduid: 460c3a3319ff4b819829c39b38e35fe9 revision: cc271ba87800178fe3b6b7c9981d814864815cc0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-09 10:16:21.667773) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-09 10:16:21.668134) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-09 10:16:21.668425) ========= 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.5l0662sdGo/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.SStxabx8AC/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.005678 basedir: '/builds/slave/test' ========= master_lag: 0.12 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-09 10:16:21.793323) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-09 10:16:21.793783) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-09 10:16:21.869113) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 10:16:21.869417) ========= 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.5l0662sdGo/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.SStxabx8AC/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.005197 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 10:16:21.961283) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-09 10:16:21.961566) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-09 10:16:21.961903) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 10:16:21.962177) ========= 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.5l0662sdGo/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.SStxabx8AC/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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-04-09 10:16:21-- 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% 161M=0s 2016-04-09 10:16:22 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.582147 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 10:16:22.628051) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 10:16:22.631511) ========= 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.5l0662sdGo/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.SStxabx8AC/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.019664 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 10:16:22.704241) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-09 10:16:22.707567) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cc271ba87800178fe3b6b7c9981d814864815cc0 --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 cc271ba87800178fe3b6b7c9981d814864815cc0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5l0662sdGo/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.SStxabx8AC/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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-04-09 10:16:22,828 truncating revision to first 12 chars 2016-04-09 10:16:22,828 Setting DEBUG logging. 2016-04-09 10:16:22,828 attempt 1/10 2016-04-09 10:16:22,828 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cc271ba87800?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-09 10:16:23,744 unpacking tar archive at: mozilla-aurora-cc271ba87800/testing/mozharness/ program finished with exit code 0 elapsedTime=1.167123 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-09 10:16:23.928291) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-09 10:16:23.928592) ========= echo cc271ba87800178fe3b6b7c9981d814864815cc0 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'cc271ba87800178fe3b6b7c9981d814864815cc0'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5l0662sdGo/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.SStxabx8AC/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 cc271ba87800178fe3b6b7c9981d814864815cc0 program finished with exit code 0 elapsedTime=0.005059 script_repo_revision: 'cc271ba87800178fe3b6b7c9981d814864815cc0' ========= master_lag: 0.13 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-09 10:16:24.063727) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-09 10:16:24.064029) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-09 10:16:24.089566) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 22 secs) (at 2016-04-09 10:16:24.089870) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5l0662sdGo/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.SStxabx8AC/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 10:16:24 INFO - MultiFileLogger online at 20160409 10:16:24 in /builds/slave/test 10:16:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:16:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:16:24 INFO - {'append_to_log': False, 10:16:24 INFO - 'base_work_dir': '/builds/slave/test', 10:16:24 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:16:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:16:24 INFO - 'branch': 'Mozilla-Aurora', 10:16:24 INFO - 'buildbot_json_path': 'buildprops.json', 10:16:24 INFO - 'config_files': ('talos/mac_config.py',), 10:16:24 INFO - 'default_actions': ('clobber', 10:16:24 INFO - 'read-buildbot-config', 10:16:24 INFO - 'download-and-extract', 10:16:24 INFO - 'populate-webroot', 10:16:24 INFO - 'create-virtualenv', 10:16:24 INFO - 'install', 10:16:24 INFO - 'run-tests'), 10:16:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:16:24 INFO - 'download_minidump_stackwalk': True, 10:16:24 INFO - 'download_symbols': 'ondemand', 10:16:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:16:24 INFO - 'tooltool.py': '/tools/tooltool.py', 10:16:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:16:24 INFO - '/tools/misc-python/virtualenv.py')}, 10:16:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:16:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:16:24 INFO - 'installer_path': 'installer.exe', 10:16:24 INFO - 'log_level': 'info', 10:16:24 INFO - 'log_name': 'talos', 10:16:24 INFO - 'log_to_console': True, 10:16:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:16:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:16:24 INFO - 'opt_config_files': (), 10:16:24 INFO - 'pip_index': False, 10:16:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:16:24 INFO - 'cmd': ('bash', 10:16:24 INFO - '-c', 10:16:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:16:24 INFO - 'enabled': True, 10:16:24 INFO - 'halt_on_failure': False, 10:16:24 INFO - 'name': 'check_screen_resolution'},), 10:16:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:16:24 INFO - 'cmd': ('bash', 10:16:24 INFO - '-c', 10:16:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:16:24 INFO - 'enabled': True, 10:16:24 INFO - 'halt_on_failure': False, 10:16:24 INFO - 'name': 'check_screen_resolution'},), 10:16:24 INFO - 'run_cmd_checks_enabled': True, 10:16:24 INFO - 'sps_profile': False, 10:16:24 INFO - 'sps_profile_interval': 0, 10:16:24 INFO - 'suite': 'dromaeojs', 10:16:24 INFO - 'system_bits': '32', 10:16:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:16:24 INFO - 'title': 't-yosemite-r7-0067', 10:16:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:16:24 INFO - 'use_talos_json': True, 10:16:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:16:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:16:24 INFO - 'work_dir': 'build'} 10:16:24 INFO - ##### 10:16:24 INFO - ##### Running clobber step. 10:16:24 INFO - ##### 10:16:24 INFO - Running pre-action listener: _resource_record_pre_action 10:16:24 INFO - Running main action method: clobber 10:16:24 INFO - rmtree: /builds/slave/test/build 10:16:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:16:25 INFO - Running post-action listener: _resource_record_post_action 10:16:25 INFO - ##### 10:16:25 INFO - ##### Running read-buildbot-config step. 10:16:25 INFO - ##### 10:16:25 INFO - Running pre-action listener: _resource_record_pre_action 10:16:25 INFO - Running main action method: read_buildbot_config 10:16:25 INFO - Using buildbot properties: 10:16:25 INFO - { 10:16:25 INFO - "project": "", 10:16:25 INFO - "product": "firefox", 10:16:25 INFO - "script_repo_revision": "production", 10:16:25 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 10:16:25 INFO - "repository": "", 10:16:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 10:16:25 INFO - "buildid": "20160409084734", 10:16:25 INFO - "pgo_build": "False", 10:16:25 INFO - "basedir": "/builds/slave/test", 10:16:25 INFO - "buildnumber": 268, 10:16:25 INFO - "slavename": "t-yosemite-r7-0067", 10:16:25 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:16:25 INFO - "platform": "yosemite_r7", 10:16:25 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 10:16:25 INFO - "branch": "mozilla-aurora", 10:16:25 INFO - "repo_path": "releases/mozilla-aurora", 10:16:25 INFO - "revision": "cc271ba87800178fe3b6b7c9981d814864815cc0", 10:16:25 INFO - "stage_platform": "macosx64", 10:16:25 INFO - "builduid": "460c3a3319ff4b819829c39b38e35fe9", 10:16:25 INFO - "slavebuilddir": "test" 10:16:25 INFO - } 10:16:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 10:16:25 INFO - Running post-action listener: _resource_record_post_action 10:16:25 INFO - ##### 10:16:25 INFO - ##### Running download-and-extract step. 10:16:25 INFO - ##### 10:16:25 INFO - Running pre-action listener: _resource_record_pre_action 10:16:25 INFO - Running main action method: download_and_extract 10:16:25 INFO - mkdir: /builds/slave/test/build/tests 10:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:25 INFO - https://queue.taskcluster.net/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:16:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 10:16:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 10:16:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JhfFApxOSqmxlofz0kTOyw/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 10:16:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JhfFApxOSqmxlofz0kTOyw/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 10:16:55 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json: timed out 10:16:55 INFO - retry: attempt #1 caught exception: timed out 10:16:55 INFO - retry: Failed, sleeping 30 seconds before retrying 10:17:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JhfFApxOSqmxlofz0kTOyw/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 #2 10:17:34 INFO - Downloaded 1277 bytes. 10:17:34 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 10:17:34 INFO - Using the following test package requirements: 10:17:34 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 10:17:34 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 10:17:34 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 10:17:34 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 10:17:34 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 10:17:34 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 10:17:34 INFO - u'jsshell-mac.zip'], 10:17:34 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 10:17:34 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 10:17:34 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 10:17:34 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 10:17:34 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 10:17:34 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 10:17:34 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 10:17:34 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 10:17:34 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 10:17:34 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 10:17:34 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 10:17:34 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 10:17:34 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 10:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:34 INFO - https://queue.taskcluster.net/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:17:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 10:17:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 10:17:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JhfFApxOSqmxlofz0kTOyw/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 10:17:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JhfFApxOSqmxlofz0kTOyw/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 10:17:51 INFO - Downloaded 17904084 bytes. 10:17:51 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'] 10:17:51 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 10:17:54 INFO - Return code: 0 10:17:54 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 10:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:54 INFO - https://queue.taskcluster.net/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:17:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 10:17:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 10:17:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JhfFApxOSqmxlofz0kTOyw/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 10:17:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JhfFApxOSqmxlofz0kTOyw/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 10:17:55 INFO - Downloaded 17904084 bytes. 10:17:55 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'] 10:17:55 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 10:17:59 INFO - Return code: 0 10:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:59 INFO - https://queue.taskcluster.net/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:17:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 10:17:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 10:17:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JhfFApxOSqmxlofz0kTOyw/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 10:17:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JhfFApxOSqmxlofz0kTOyw/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 10:18:00 INFO - Downloaded 10845168 bytes. 10:18:00 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'] 10:18:00 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 10:18:00 INFO - Return code: 0 10:18:00 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')]} 10:18:00 INFO - https://queue.taskcluster.net/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 10:18:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 10:18:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 10:18:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 10:18:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JhfFApxOSqmxlofz0kTOyw/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 10:18:03 INFO - Downloaded 115192492 bytes. 10:18:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 10:18:03 INFO - mkdir: /builds/slave/test/properties 10:18:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:18:03 INFO - Writing to file /builds/slave/test/properties/build_url 10:18:03 INFO - Contents: 10:18:03 INFO - build_url:https://queue.taskcluster.net/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 10:18:04 INFO - Running post-action listener: _resource_record_post_action 10:18:04 INFO - Running post-action listener: set_extra_try_arguments 10:18:04 INFO - ##### 10:18:04 INFO - ##### Running populate-webroot step. 10:18:04 INFO - ##### 10:18:04 INFO - Running pre-action listener: _resource_record_pre_action 10:18:04 INFO - Running main action method: populate_webroot 10:18:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:18:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:18:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:18:04 INFO - '--tppagecycles', 10:18:04 INFO - '7'], 10:18:04 INFO - 'tests': ['tsvgm']}}, 10:18:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:18:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:18:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:18:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:18:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:18:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:18:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:18:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:04 INFO - 'talos_options': ['--e10s'], 10:18:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:18:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:04 INFO - 'tests': ['damp', 'tps']}, 10:18:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:04 INFO - 'talos_options': ['--e10s'], 10:18:04 INFO - 'tests': ['damp', 'tps']}, 10:18:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:18:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:18:04 INFO - 'other': {'tests': ['a11yr', 10:18:04 INFO - 'ts_paint', 10:18:04 INFO - 'tpaint', 10:18:04 INFO - 'sessionrestore', 10:18:04 INFO - 'sessionrestore_no_auto_restore', 10:18:04 INFO - 'tabpaint']}, 10:18:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:18:04 INFO - 'tests': ['a11yr', 10:18:04 INFO - 'ts_paint', 10:18:04 INFO - 'tpaint', 10:18:04 INFO - 'sessionrestore', 10:18:04 INFO - 'sessionrestore_no_auto_restore', 10:18:04 INFO - 'tabpaint']}, 10:18:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:18:04 INFO - 'tests': ['a11yr', 10:18:04 INFO - 'ts_paint', 10:18:04 INFO - 'tpaint', 10:18:04 INFO - 'sessionrestore', 10:18:04 INFO - 'sessionrestore_no_auto_restore', 10:18:04 INFO - 'tabpaint']}, 10:18:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:18:04 INFO - 'tests': ['a11yr', 10:18:04 INFO - 'ts_paint', 10:18:04 INFO - 'tpaint', 10:18:04 INFO - 'sessionrestore', 10:18:04 INFO - 'sessionrestore_no_auto_restore', 10:18:04 INFO - 'tabpaint']}, 10:18:04 INFO - 'other_l64': {'tests': ['a11yr', 10:18:04 INFO - 'ts_paint', 10:18:04 INFO - 'tpaint', 10:18:04 INFO - 'sessionrestore', 10:18:04 INFO - 'sessionrestore_no_auto_restore', 10:18:04 INFO - 'tabpaint']}, 10:18:04 INFO - 'other_nol64': {'tests': ['a11yr', 10:18:04 INFO - 'ts_paint', 10:18:04 INFO - 'tpaint', 10:18:04 INFO - 'sessionrestore', 10:18:04 INFO - 'sessionrestore_no_auto_restore', 10:18:04 INFO - 'tabpaint']}, 10:18:04 INFO - 'svgr': {'tests': ['tsvgx', 10:18:04 INFO - 'tsvgr_opacity', 10:18:04 INFO - 'tart', 10:18:04 INFO - 'tscrollx', 10:18:04 INFO - 'cart']}, 10:18:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:18:04 INFO - 'tests': ['tsvgx', 10:18:04 INFO - 'tsvgr_opacity', 10:18:04 INFO - 'tart', 10:18:04 INFO - 'tscrollx', 10:18:04 INFO - 'cart']}, 10:18:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:04 INFO - 'tests': ['tp5o']}, 10:18:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:04 INFO - 'talos_options': ['--e10s'], 10:18:04 INFO - 'tests': ['tp5o']}, 10:18:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:04 INFO - 'talos_options': ['--xperf_path', 10:18:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:18:04 INFO - 'tests': ['tp5n']}, 10:18:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:04 INFO - 'talos_options': ['--e10s', 10:18:04 INFO - '--xperf_path', 10:18:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:18:04 INFO - 'tests': ['tp5n']}}, 10:18:04 INFO - 'talos.zip': {'path': '', 10:18:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:18:04 INFO - Running post-action listener: _resource_record_post_action 10:18:04 INFO - ##### 10:18:04 INFO - ##### Running create-virtualenv step. 10:18:04 INFO - ##### 10:18:04 INFO - Running pre-action listener: _resource_record_pre_action 10:18:04 INFO - Running main action method: create_virtualenv 10:18:04 INFO - Creating virtualenv /builds/slave/test/build/venv 10:18:04 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 10:18:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:18:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:18:04 INFO - Using real prefix '/tools/python27' 10:18:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:18:04 INFO - Installing distribute.............................................................................................................................................................................................done. 10:18:07 INFO - Installing pip.................done. 10:18:07 INFO - Return code: 0 10:18:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:18: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')]} 10:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18: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')]} 10:18:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ff1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ff84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91395a6ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e95d30>, '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 0x103cf9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e8cb20>, '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.5l0662sdGo/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.SStxabx8AC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 10:18:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:18:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5l0662sdGo/Render', 10:18:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:07 INFO - 'HOME': '/Users/cltbld', 10:18:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:07 INFO - 'LOGNAME': 'cltbld', 10:18:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:07 INFO - 'MOZ_NO_REMOTE': '1', 10:18:07 INFO - 'NO_EM_RESTART': '1', 10:18:07 INFO - 'PAGER': '/bin/cat', 10:18:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:07 INFO - 'PWD': '/builds/slave/test', 10:18:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:07 INFO - 'SHELL': '/bin/bash', 10:18:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SStxabx8AC/Listeners', 10:18:07 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 10:18:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:07 INFO - 'USER': 'cltbld', 10:18:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:07 INFO - 'XPC_FLAGS': '0x0', 10:18:07 INFO - 'XPC_SERVICE_NAME': '0', 10:18:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:08 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 10:18:08 INFO - Cleaning up... 10:18:08 INFO - Return code: 0 10:18:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:08 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 0x103ff1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ff84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91395a6ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e95d30>, '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 0x103cf9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e8cb20>, '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.5l0662sdGo/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.SStxabx8AC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 10:18:08 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 10:18:08 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 10:18:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5l0662sdGo/Render', 10:18:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:08 INFO - 'HOME': '/Users/cltbld', 10:18:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:08 INFO - 'LOGNAME': 'cltbld', 10:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:08 INFO - 'MOZ_NO_REMOTE': '1', 10:18:08 INFO - 'NO_EM_RESTART': '1', 10:18:08 INFO - 'PAGER': '/bin/cat', 10:18:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:08 INFO - 'PWD': '/builds/slave/test', 10:18:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:08 INFO - 'SHELL': '/bin/bash', 10:18:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SStxabx8AC/Listeners', 10:18:08 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 10:18:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:08 INFO - 'USER': 'cltbld', 10:18:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:08 INFO - 'XPC_FLAGS': '0x0', 10:18:08 INFO - 'XPC_SERVICE_NAME': '0', 10:18:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:08 INFO - Downloading/unpacking psutil>=0.7.1 10:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:18:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:18:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:18:11 INFO - Installing collected packages: psutil 10:18:11 INFO - Running setup.py install for psutil 10:18:11 INFO - building 'psutil._psutil_osx' extension 10:18:11 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 10:18:11 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 10:18:11 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 10:18:11 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 10:18:11 INFO - building 'psutil._psutil_posix' extension 10:18:11 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 10:18:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:18:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:18:11 INFO - ^ 10:18:11 INFO - 1 warning generated. 10:18:11 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 10:18:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:18:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:18:12 INFO - Successfully installed psutil 10:18:12 INFO - Cleaning up... 10:18:12 INFO - Return code: 0 10:18:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:18:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:12 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 0x103ff1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ff84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91395a6ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e95d30>, '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 0x103cf9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e8cb20>, '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.5l0662sdGo/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.SStxabx8AC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 10:18:12 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 10:18:12 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 10:18:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5l0662sdGo/Render', 10:18:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:12 INFO - 'HOME': '/Users/cltbld', 10:18:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:12 INFO - 'LOGNAME': 'cltbld', 10:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:12 INFO - 'MOZ_NO_REMOTE': '1', 10:18:12 INFO - 'NO_EM_RESTART': '1', 10:18:12 INFO - 'PAGER': '/bin/cat', 10:18:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:12 INFO - 'PWD': '/builds/slave/test', 10:18:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:12 INFO - 'SHELL': '/bin/bash', 10:18:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SStxabx8AC/Listeners', 10:18:12 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 10:18:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:12 INFO - 'USER': 'cltbld', 10:18:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:12 INFO - 'XPC_FLAGS': '0x0', 10:18:12 INFO - 'XPC_SERVICE_NAME': '0', 10:18:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:18:12 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 10:18:12 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 10:18:12 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 10:18:12 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 10:18:12 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 10:18:12 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 10:18:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:18:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:18:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:18:14 INFO - Installing collected packages: mozsystemmonitor 10:18:14 INFO - Running setup.py install for mozsystemmonitor 10:18:15 INFO - Successfully installed mozsystemmonitor 10:18:15 INFO - Cleaning up... 10:18:15 INFO - Return code: 0 10:18:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:18:15 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')]} 10:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:15 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')]} 10:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:15 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 0x103ff1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ff84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91395a6ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e95d30>, '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 0x103cf9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e8cb20>, '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.5l0662sdGo/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.SStxabx8AC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 10:18:15 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 10:18:15 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 10:18:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5l0662sdGo/Render', 10:18:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:15 INFO - 'HOME': '/Users/cltbld', 10:18:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:15 INFO - 'LOGNAME': 'cltbld', 10:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:15 INFO - 'MOZ_NO_REMOTE': '1', 10:18:15 INFO - 'NO_EM_RESTART': '1', 10:18:15 INFO - 'PAGER': '/bin/cat', 10:18:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:15 INFO - 'PWD': '/builds/slave/test', 10:18:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:15 INFO - 'SHELL': '/bin/bash', 10:18:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SStxabx8AC/Listeners', 10:18:15 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 10:18:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:15 INFO - 'USER': 'cltbld', 10:18:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:15 INFO - 'XPC_FLAGS': '0x0', 10:18:15 INFO - 'XPC_SERVICE_NAME': '0', 10:18:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:15 INFO - Downloading/unpacking blobuploader==1.2.4 10:18:15 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 10:18:15 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 10:18:15 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 10:18:15 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 10:18:15 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 10:18:15 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 10:18:17 INFO - Downloading blobuploader-1.2.4.tar.gz 10:18:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:18:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:18:17 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 10:18:17 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 10:18:17 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 10:18:17 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 10:18:17 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 10:18:17 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 10:18:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:18:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:18 INFO - Downloading docopt-0.6.1.tar.gz 10:18:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:18:19 INFO - Installing collected packages: blobuploader, requests, docopt 10:18:19 INFO - Running setup.py install for blobuploader 10:18:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:18:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:18:19 INFO - Running setup.py install for requests 10:18:19 INFO - Running setup.py install for docopt 10:18:19 INFO - Successfully installed blobuploader requests docopt 10:18:19 INFO - Cleaning up... 10:18:19 INFO - Return code: 0 10:18:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:18: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')]} 10:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18: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')]} 10:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:19 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 0x103ff1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ff84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91395a6ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e95d30>, '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 0x103cf9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e8cb20>, '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.5l0662sdGo/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.SStxabx8AC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 10:18:19 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 10:18:19 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 10:18:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5l0662sdGo/Render', 10:18:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:19 INFO - 'HOME': '/Users/cltbld', 10:18:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:19 INFO - 'LOGNAME': 'cltbld', 10:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:19 INFO - 'MOZ_NO_REMOTE': '1', 10:18:19 INFO - 'NO_EM_RESTART': '1', 10:18:19 INFO - 'PAGER': '/bin/cat', 10:18:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:19 INFO - 'PWD': '/builds/slave/test', 10:18:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:19 INFO - 'SHELL': '/bin/bash', 10:18:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SStxabx8AC/Listeners', 10:18:19 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 10:18:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:19 INFO - 'USER': 'cltbld', 10:18:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:19 INFO - 'XPC_FLAGS': '0x0', 10:18:19 INFO - 'XPC_SERVICE_NAME': '0', 10:18:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:18:20 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-wIJpxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:18:20 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-DN_PVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:18:20 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-G8RX2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:18:20 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-S_Xcsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:18:20 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-8P1SO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:18:20 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-EYHmZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:18:20 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-wXHs5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:18:21 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-ODCbYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:18:21 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-j4Tla1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:18:21 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-qVYNwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:18:21 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-zNIRYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:18:21 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-50l7xV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:18:21 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-QY67pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:18:21 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-lxXCCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:18:21 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-U8VKKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:18:21 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-KdOpaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:18:21 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-Y3RyW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:18:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:18:22 INFO - Running setup.py install for manifestparser 10:18:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:18:22 INFO - Running setup.py install for mozcrash 10:18:22 INFO - Running setup.py install for mozdebug 10:18:22 INFO - Running setup.py install for mozdevice 10:18:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:18:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:18:22 INFO - Running setup.py install for mozfile 10:18:22 INFO - Running setup.py install for mozhttpd 10:18:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:18:22 INFO - Running setup.py install for mozinfo 10:18:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:18:23 INFO - Running setup.py install for mozInstall 10:18:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:18:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:18:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:18:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:18:23 INFO - Running setup.py install for mozleak 10:18:23 INFO - Running setup.py install for mozlog 10:18:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:18:23 INFO - Running setup.py install for moznetwork 10:18:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:18:23 INFO - Running setup.py install for mozprocess 10:18:23 INFO - Running setup.py install for mozprofile 10:18:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:18:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:18:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:18:23 INFO - Running setup.py install for mozrunner 10:18:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:18:24 INFO - Running setup.py install for mozscreenshot 10:18:24 INFO - Running setup.py install for moztest 10:18:24 INFO - Running setup.py install for mozversion 10:18:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:18:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:18:24 INFO - Cleaning up... 10:18:24 INFO - Return code: 0 10:18:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:18:24 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')]} 10:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:24 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')]} 10:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:24 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 0x103ff1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ff84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91395a6ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e95d30>, '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 0x103cf9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e8cb20>, '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.5l0662sdGo/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.SStxabx8AC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 10:18:24 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 10:18:24 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 10:18:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5l0662sdGo/Render', 10:18:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:24 INFO - 'HOME': '/Users/cltbld', 10:18:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:24 INFO - 'LOGNAME': 'cltbld', 10:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:24 INFO - 'MOZ_NO_REMOTE': '1', 10:18:24 INFO - 'NO_EM_RESTART': '1', 10:18:24 INFO - 'PAGER': '/bin/cat', 10:18:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:24 INFO - 'PWD': '/builds/slave/test', 10:18:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:24 INFO - 'SHELL': '/bin/bash', 10:18:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SStxabx8AC/Listeners', 10:18:24 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 10:18:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:24 INFO - 'USER': 'cltbld', 10:18:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:24 INFO - 'XPC_FLAGS': '0x0', 10:18:24 INFO - 'XPC_SERVICE_NAME': '0', 10:18:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:18:24 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-rogGal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:18:25 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)) 10:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:18:25 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-nHwYVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:18:25 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)) 10:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:18:25 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-HD49Sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:18:25 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)) 10:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:18:25 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-t6AbvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:18:25 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)) 10:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:18:25 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-GeIcMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:18:25 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)) 10:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:18:25 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-NjM0w7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:18:25 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)) 10:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:18:25 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-s631KL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:18:25 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)) 10:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:18:25 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-INk4ye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:18:25 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)) 10:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:18:25 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-RrJ9v5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:18:25 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)) 10:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:18:25 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-Ul9SlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:18:25 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)) 10:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:18:25 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-DpdiV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:18:26 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)) 10:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:18:26 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-hUeniT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:18:26 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)) 10:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:18:26 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-fj9cIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:18:26 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)) 10:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:18:26 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-4Sgrva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:18:26 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)) 10:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:18:26 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-c5redl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:18:26 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)) 10:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:18:26 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-__xGt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:18:26 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)) 10:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:18:26 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-KSH6N3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:18:26 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)) 10:18:26 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)) 10:18:26 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)) 10:18:26 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)) 10:18:26 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)) 10:18:26 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)) 10:18:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:29 INFO - Downloading blessings-1.6.tar.gz 10:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:18:29 INFO - Installing collected packages: blessings 10:18:29 INFO - Running setup.py install for blessings 10:18:29 INFO - Successfully installed blessings 10:18:29 INFO - Cleaning up... 10:18:29 INFO - Return code: 0 10:18:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:18:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:18:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:18:30 INFO - Reading from file tmpfile_stdout 10:18:30 INFO - Current package versions: 10:18:30 INFO - blessings == 1.6 10:18:30 INFO - blobuploader == 1.2.4 10:18:30 INFO - docopt == 0.6.1 10:18:30 INFO - manifestparser == 1.1 10:18:30 INFO - mozInstall == 1.12 10:18:30 INFO - mozcrash == 0.17 10:18:30 INFO - mozdebug == 0.1 10:18:30 INFO - mozdevice == 0.48 10:18:30 INFO - mozfile == 1.2 10:18:30 INFO - mozhttpd == 0.7 10:18:30 INFO - mozinfo == 0.9 10:18:30 INFO - mozleak == 0.1 10:18:30 INFO - mozlog == 3.1 10:18:30 INFO - moznetwork == 0.27 10:18:30 INFO - mozprocess == 0.22 10:18:30 INFO - mozprofile == 0.28 10:18:30 INFO - mozrunner == 6.11 10:18:30 INFO - mozscreenshot == 0.1 10:18:30 INFO - mozsystemmonitor == 0.0 10:18:30 INFO - moztest == 0.7 10:18:30 INFO - mozversion == 1.4 10:18:30 INFO - psutil == 3.1.1 10:18:30 INFO - requests == 1.2.3 10:18:30 INFO - wsgiref == 0.1.2 10:18:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:18:30 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')]} 10:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:30 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')]} 10:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:30 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 0x103ff1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ff84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91395a6ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e95d30>, '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 0x103cf9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e8cb20>, '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.5l0662sdGo/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.SStxabx8AC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 10:18:30 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 10:18:30 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 10:18:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5l0662sdGo/Render', 10:18:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:30 INFO - 'HOME': '/Users/cltbld', 10:18:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:30 INFO - 'LOGNAME': 'cltbld', 10:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:30 INFO - 'MOZ_NO_REMOTE': '1', 10:18:30 INFO - 'NO_EM_RESTART': '1', 10:18:30 INFO - 'PAGER': '/bin/cat', 10:18:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:30 INFO - 'PWD': '/builds/slave/test', 10:18:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:30 INFO - 'SHELL': '/bin/bash', 10:18:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SStxabx8AC/Listeners', 10:18:30 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 10:18:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:30 INFO - 'USER': 'cltbld', 10:18:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:30 INFO - 'XPC_FLAGS': '0x0', 10:18:30 INFO - 'XPC_SERVICE_NAME': '0', 10:18:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:30 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)) 10:18:30 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)) 10:18:30 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)) 10:18:30 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)) 10:18:30 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)) 10:18:30 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)) 10:18:30 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)) 10:18:30 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)) 10:18:30 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)) 10:18:30 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)) 10:18:30 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)) 10:18:30 INFO - Cleaning up... 10:18:30 INFO - Return code: 0 10:18:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:18:30 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')]} 10:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:30 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')]} 10:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:30 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 0x103ff1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ff84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91395a6ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e95d30>, '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 0x103cf9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e8cb20>, '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.5l0662sdGo/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.SStxabx8AC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 10:18:30 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 10:18:30 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 10:18:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5l0662sdGo/Render', 10:18:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:30 INFO - 'HOME': '/Users/cltbld', 10:18:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:30 INFO - 'LOGNAME': 'cltbld', 10:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:30 INFO - 'MOZ_NO_REMOTE': '1', 10:18:30 INFO - 'NO_EM_RESTART': '1', 10:18:30 INFO - 'PAGER': '/bin/cat', 10:18:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:30 INFO - 'PWD': '/builds/slave/test', 10:18:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:30 INFO - 'SHELL': '/bin/bash', 10:18:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SStxabx8AC/Listeners', 10:18:30 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 10:18:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:30 INFO - 'USER': 'cltbld', 10:18:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:30 INFO - 'XPC_FLAGS': '0x0', 10:18:30 INFO - 'XPC_SERVICE_NAME': '0', 10:18:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:30 INFO - Downloading/unpacking jsonschema 10:18:30 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 10:18:30 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 10:18:30 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 10:18:30 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 10:18:30 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 10:18:30 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 10:18:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:18:33 INFO - Downloading/unpacking functools32 (from jsonschema) 10:18: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 10:18: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 10:18: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 10:18: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 10:18: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 10:18: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 10:18:33 INFO - Downloading functools32-3.2.3-2.tar.gz 10:18:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:18:33 INFO - warning: no files found matching '*.txt' 10:18:33 INFO - no previously-included directories found matching 'build' 10:18:33 INFO - no previously-included directories found matching 'dist' 10:18:33 INFO - no previously-included directories found matching '.git*' 10:18:33 INFO - Installing collected packages: jsonschema, functools32 10:18:33 INFO - Running setup.py install for functools32 10:18:33 INFO - warning: no files found matching '*.txt' 10:18:33 INFO - no previously-included directories found matching 'build' 10:18:33 INFO - no previously-included directories found matching 'dist' 10:18:33 INFO - no previously-included directories found matching '.git*' 10:18:33 INFO - Successfully installed jsonschema functools32 10:18:33 INFO - Cleaning up... 10:18:34 INFO - Return code: 0 10:18:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:34 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 0x103ff1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ff84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91395a6ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e95d30>, '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 0x103cf9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e8cb20>, '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.5l0662sdGo/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.SStxabx8AC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 10:18:34 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 10:18:34 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 10:18:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5l0662sdGo/Render', 10:18:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:34 INFO - 'HOME': '/Users/cltbld', 10:18:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:34 INFO - 'LOGNAME': 'cltbld', 10:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:34 INFO - 'MOZ_NO_REMOTE': '1', 10:18:34 INFO - 'NO_EM_RESTART': '1', 10:18:34 INFO - 'PAGER': '/bin/cat', 10:18:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:34 INFO - 'PWD': '/builds/slave/test', 10:18:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:34 INFO - 'SHELL': '/bin/bash', 10:18:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SStxabx8AC/Listeners', 10:18:34 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 10:18:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:34 INFO - 'USER': 'cltbld', 10:18:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:34 INFO - 'XPC_FLAGS': '0x0', 10:18:34 INFO - 'XPC_SERVICE_NAME': '0', 10:18:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:34 INFO - Downloading/unpacking flake8 10:18:34 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 10:18:34 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 10:18:34 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 10:18:34 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 10:18:34 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 10:18:34 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 10:18:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:18:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:18:36 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 10:18:36 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 10:18:36 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 10:18:36 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 10:18:36 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 10:18:36 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 10:18:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:18:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:18:37 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 10:18:37 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 10:18:37 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 10:18:37 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 10:18:37 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 10:18:37 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 10:18:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:18:37 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 10:18:37 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 10:18:37 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 10:18:37 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 10:18:37 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 10:18:37 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 10:18:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:18:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:18:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:18:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:18:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:18:38 INFO - no previously-included directories found matching 'docs/_build' 10:18:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:18:38 INFO - Running setup.py install for pep8 10:18:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:18:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:18:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:18:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:18:38 INFO - no previously-included directories found matching 'docs/_build' 10:18:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:18:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:18:38 INFO - Cleaning up... 10:18:38 INFO - Return code: 0 10:18:38 INFO - Running post-action listener: _resource_record_post_action 10:18:38 INFO - Running post-action listener: _start_resource_monitoring 10:18:38 INFO - Starting resource monitoring. 10:18:38 INFO - ##### 10:18:38 INFO - ##### Running install step. 10:18:38 INFO - ##### 10:18:38 INFO - Running pre-action listener: _resource_record_pre_action 10:18:38 INFO - Running main action method: install 10:18:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:18:38 INFO - Reading from file tmpfile_stdout 10:18:38 INFO - Detecting whether we're running mozinstall >=1.0... 10:18:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:18:38 INFO - Reading from file tmpfile_stdout 10:18:38 INFO - Output received: 10:18:38 INFO - Usage: mozinstall [options] installer 10:18:38 INFO - Options: 10:18:38 INFO - -h, --help show this help message and exit 10:18:38 INFO - -d DEST, --destination=DEST 10:18:38 INFO - Directory to install application into. [default: 10:18:38 INFO - "/builds/slave/test"] 10:18:38 INFO - --app=APP Application being installed. [default: firefox] 10:18:38 INFO - mkdir: /builds/slave/test/build/application 10:18:38 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'] 10:18:38 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 10:19:10 INFO - Reading from file tmpfile_stdout 10:19:10 INFO - Output received: 10:19:10 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 10:19:10 INFO - Running post-action listener: _resource_record_post_action 10:19:10 INFO - ##### 10:19:10 INFO - ##### Running run-tests step. 10:19:10 INFO - ##### 10:19:10 INFO - Running pre-action listener: _resource_record_pre_action 10:19:10 INFO - Running main action method: run_tests 10:19:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:19:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:19:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:19:10 INFO - 2016-04-09 10:19:10.728 screenresolution[1947:13240] starting screenresolution argv=screenresolution get 10:19:10 INFO - 2016-04-09 10:19:10.731 screenresolution[1947:13240] Display 0: 1600x1200x32@60 10:19:10 INFO - 2016-04-09 10:19:10.737 screenresolution[1948:13243] starting screenresolution argv=screenresolution list 10:19:10 INFO - Available Modes on Display 0 10:19:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:19:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:19:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:19:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:19:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:19:10 INFO - Intel Iris: 10:19:10 INFO - Chipset Model: Intel Iris 10:19:10 INFO - Type: GPU 10:19:10 INFO - Bus: Built-In 10:19:10 INFO - VRAM (Dynamic, Max): 1536 MB 10:19:10 INFO - Vendor: Intel (0x8086) 10:19:10 INFO - Device ID: 0x0a2e 10:19:10 INFO - Revision ID: 0x0009 10:19:10 INFO - Displays: 10:19:10 INFO - Display: 10:19:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:19:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:19:10 INFO - Display Serial Number: 1600x1200 60 10:19:10 INFO - Main Display: Yes 10:19:10 INFO - Mirror: Off 10:19:10 INFO - Online: Yes 10:19:10 INFO - Rotation: Supported 10:19:10 INFO - Return code: 0 10:19:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:19:10 INFO - Python 2.7.3 10:19:10 INFO - Return code: 0 10:19:10 INFO - grabbing minidump binary from tooltool 10:19:10 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')]} 10:19:10 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 0x103e95d30>, '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 0x103cf9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e8cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:19:10 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 10:19:10 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 10:19:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:19:11 INFO - Return code: 0 10:19:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:19:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:19:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:19:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:19:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:19:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:19:12 INFO - Return code: 0 10:19:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:19:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5l0662sdGo/Render', 10:19:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:12 INFO - 'HOME': '/Users/cltbld', 10:19:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:12 INFO - 'LOGNAME': 'cltbld', 10:19:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:19:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:12 INFO - 'MOZ_NO_REMOTE': '1', 10:19:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:19:12 INFO - 'NO_EM_RESTART': '1', 10:19:12 INFO - 'PAGER': '/bin/cat', 10:19:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:12 INFO - 'PWD': '/builds/slave/test', 10:19:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:19:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:12 INFO - 'SHELL': '/bin/bash', 10:19:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SStxabx8AC/Listeners', 10:19:12 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 10:19:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:12 INFO - 'USER': 'cltbld', 10:19:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:12 INFO - 'XPC_FLAGS': '0x0', 10:19:12 INFO - 'XPC_SERVICE_NAME': '0', 10:19:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:19:12 INFO - mozversion application_buildid: 20160409084734 10:19:12 INFO - mozversion application_changeset: cc271ba87800178fe3b6b7c9981d814864815cc0 10:19:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:19:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:19:12 INFO - mozversion application_name: Firefox 10:19:12 INFO - mozversion application_remotingname: firefox-dev 10:19:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:19:12 INFO - mozversion application_vendor: Mozilla 10:19:12 INFO - mozversion application_version: 47.0a2 10:19:12 INFO - mozversion platform_buildid: 20160409084734 10:19:12 INFO - mozversion platform_changeset: cc271ba87800178fe3b6b7c9981d814864815cc0 10:19:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:19:12 INFO - mozversion platform_version: 47.0a2 10:19:12 INFO - using testdate: 1460222352 10:19:12 INFO - actual date: 1460222352 10:19:12 INFO - starting webserver on 'localhost:49486' 10:19:12 INFO - SUITE-START | Running 2 tests 10:19:12 INFO - TEST-START | dromaeo_css 10:19:12 INFO - operating with platform_type : mac_ 10:19:12 INFO - Initialising browser for dromaeo_css test... 10:19:12 INFO - TEST-INFO | started process 1966 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmpAl4m_T/profile http://localhost:49486/getInfo.html) 10:19:14 INFO - PROCESS | 1966 | __metrics Screen width/height:1600/1200 10:19:14 INFO - PROCESS | 1966 | colorDepth:24 10:19:14 INFO - PROCESS | 1966 | Browser inner width/height: 1024/689 10:19:14 INFO - PROCESS | 1966 | __metrics 10:19:14 INFO - PROCESS | 1966 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:19:14 INFO - PROCESS | 1966 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:19:15 INFO - TEST-INFO | 1966: exit 0 10:19:15 INFO - Browser initialized. 10:19:15 INFO - Running cycle 1/1 for dromaeo_css test... 10:19:15 INFO - TEST-INFO | started process 1968 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmpAl4m_T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:19:27 INFO - PROCESS | 1968 | RSS: Main: 207450112 10:19:27 INFO - PROCESS | 1968 | 10:20:18 INFO - PROCESS | 1968 | 1460222418580 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] 10:22:28 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49486/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49486/tests/dromaeo/cssquery-ext.html) 10:22:30 INFO - PROCESS | 1968 | RSS: Main: 319692800 10:22:30 INFO - PROCESS | 1968 | 10:25:32 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49486/tests/dromaeo/cssquery-ext.html (next: http://localhost:49486/tests/dromaeo/cssquery-jquery.html) 10:25:32 INFO - PROCESS | 1968 | RSS: Main: 331055104 10:25:32 INFO - PROCESS | 1968 | 10:28:34 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49486/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49486/tests/dromaeo/cssquery-mootools.html) 10:28:35 INFO - PROCESS | 1968 | RSS: Main: 341454848 10:28:35 INFO - PROCESS | 1968 | 10:31:37 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49486/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49486/tests/dromaeo/cssquery-prototype.html) 10:31:38 INFO - PROCESS | 1968 | RSS: Main: 304402432 10:31:38 INFO - PROCESS | 1968 | 10:34:41 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49486/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49486/tests/dromaeo/cssquery-yui.html) 10:34:41 INFO - PROCESS | 1968 | RSS: Main: 305651712 10:34:41 INFO - PROCESS | 1968 | 10:37:44 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49486/tests/dromaeo/cssquery-yui.html (next: http://localhost:49486/tests/dromaeo/cssquery-dojo.html) 10:37:44 INFO - PROCESS | 1968 | RSS: Main: 354086912 10:37:44 INFO - PROCESS | 1968 | 10:37:44 INFO - PROCESS | 1968 | __start_tp_report 10:37:44 INFO - PROCESS | 1968 | _x_x_mozilla_page_load 10:37:44 INFO - PROCESS | 1968 | _x_x_mozilla_page_load_details 10:37:44 INFO - PROCESS | 1968 | |i|pagename|runs| 10:37:44 INFO - PROCESS | 1968 | |0;dojo.html;3410.675985781351;3428.4857271409287;3457.273972465782;3460.515527826104;3522.2955408918206;5681.318241810978;5688.232088668028;5689.658620482764;5704.087346024637;5716.742746576404;5663.546916246701;5716.199732037508;5730.169125476803;5736.799212027579;5738.42615738427;5102;5149.459306772791;5216.400113986892;5282.181261904392;5292.603054770908;5252.894942101156;5253.44838791927;5255.763490642911;5256.605754568403;5276.630635855492;5207.6354655174155;5258.579313654917;5261.105612045962;5268.262443257947;5284.39229488608;5261.86845328866;5302.019126461617;5313.149896016657;5315.468453154692;5327.200919862013;5061.974690126526;5213.4004589472315;5221.765020574083;5229.633925625208;5264.341957255343;5602.271704678406;5615.522680572156;5618.073017952033;5649.12438572022;5654.236678048493;6135.202423684892;6199.597026193283;6201.162843016225;6214.8135555933395;6235.376462353774;5233.4243233244315;6104.267487901436;6193.4425901669065;6194.287656919467;6213.2233470816145;5819.854503637401;5844.561657875676;5848.210491583667;5850.122481627747;5850.5027072699295;6114.663693496811;6193.628382297076;6232.968835155886;6233.470155036873;6251.6561589113035;6150.169727086875;6172.197614310111;6180.81457556274;6185.010398336244;6187.16473276111;6185.752569897244;6188.628682278988;6197.938020619736;6202.937970620236;6212.844678883064;6039.305479869783;6116.866227185065;6161.507079433634;6209.130721698965;6222.3466536013975;6178.598391104564;6184.5980011299125;6221.191245138193;6227.9377206227355;6242.906356404657;4899.314096026559;4901.43633482147;4910.999999999928;4913.852584422473;4929.950700493021;3712.6472985066375;4348.391225228471;4451.621612162938;4462.352958820953;4467.6202522785925;5679.517241034476;5692.857678558069;5717.256756621696;5720.256366672389;5796.072628379439;6235.501159907287;6235.96882015587;6237.1891654084675;6238.1266622672865;6247.031710084853;5533.114701647717;5647.322321321386;5680.715964201773;5709.628874123168;5747.770089196469;5323.0950738373795;5342.439043900412;5359.490848369399;5373.623846330797;5413.566914646897;6322;6335.873282534231;6340.873182536324;6341.619502829845;6354.745810167634;6118.923762351665;6145.033589251575;6197.03945888388;6200.689965501617;6234.501239900887;6286.748530058747;6305.5901366411035;6340;6355.332690067661;6360.300366959723;6189.071639254148;6198.2252218472695;6211.378862113753;6211.440970312694;6218.906716399348;5910.7340169693325;6139.676133582418;6203.844903877439;6260.655663938527;6298.496120310272;6054.697265136813;6119.296280927751;6132.141500190066;6135.233095863017;6141.570090093651;6102.908456373069;6109.75560977556;6141.263048434216;6154.3845615438095;6160.44555989963;5771.913421298768;5921.644701317935;5985.132155837292;6043.758249669964;6056.515478761777;6107.67434349443;6108.969455152695;6118.05942802523;6131.321207275599;6139.416755408229;5806.419358064329;5911.231539899785;5978.581499295007;5989.2812862456785;6008.03871380577 10:37:44 INFO - PROCESS | 1968 | |1;ext.html;493.2305603258914;576.6050255574931;595.027130641401;662.903878937554;671.4158681946707;31249.531257031133;40999.975000624996;41022.17955640885;41087.58912410875;41167.58832411675;43182.56817431825;43808.56191438084;43930;43934.56065439345;43945;9651.131398174146;9752.902470975307;9861.408315501058;9892.604295828158;9896.851547226797;8937.240334571568;9191.770205744877;9736.659216927408;9909.603615855358;9912.603495860158;9835.213182945383;10052.296339256254;10059.798804023914;10065.547050382715;10066.69799906004;9949.403035817837;10037.598496060149;10045.799084018352;10047;10067.647632332833;9802.607895684236;9847.753806154831;9949;9950.701478955643;9963.70108896727;42437.36343954843;42811.7859410701;42827.35758963618;42862.928426789265;42986;3458.792472451661;3828.540575130974;3891.20230352777;3903.531576210873;3922.293987082324;24722.752772472406;29552.26119347012;29733;29842.70157298421;30098.54852177219;2448.4490989527394;2748.9862550687317;2774.9445011099665;2882.654081510211;2901.7533509651703;461493;469187.99999999657;470420;471231;471438;39837.402438963436;69068.6546567264;69179.65410172917;69432.65283673651;69747.65126174336;48382.27426588604;48542;48565;48645;48695.269570956465;17220.741688874426;17362;17367.218475168647;17372.39196628112;17388.391406300972;13826.101303415246;13915.30423478822;13915.860841391659;13916.443342266399;13942.302884855717;15600.453984110729;15609.219539023003;15691.450799221973;15699.450519231772;15731.921340393454;5491.423400542965;6611;6611.603303801788;6663.301362948014;6679.165104361955;970.7184916374173;984.3257368702461;1008.5915204342253;1030.9639162629271;1101.1906248907046;25552.48895022089;25574.872125639624;30280.54579181314;30407.543886841715;30801.229969250948;1146.3866831245243;1166.3585028234438;1176.3588844079998;1192.928424294545;1204.873488283735;13819.090454772613;16356.754648680278;16477.752833707505;16567.50297491077;16661.750073748903;444228;671928;683947;684331;685605;60508.394916051155;60867.39132608706;61421.38578614246;61502.38497615056;61525;1209.909256805743;1449.2101804516353;1540.6456515001612;1563.7185306644913;1681.991590042042;30256.84871575628;32232.19419514531;33024.50463243005;33089.834550827094;33462.330753385286;51109;58341;59370.10944835745;59382.10926836187;59394;438019;439334;441521;441603;442308.30766770255;30086.398272034;33828;34208.657913420546;34669;34744.652553474145;41769;42628.5737142637;42677.14645707131;43431.9142021452;43484.34773478337;34434.82782586071;35382.8230858844;35559.288814224084;35852.28295434129;36453.45319820152;35752.463713043806;35814.820925895205;36089.81955090313;36457.90626281216;36515.452268215464;36566.817165914;36761.448578270814;37111.44332835064;37134.8143259282;37296.62703372932;31853.840730796197;32760.50859237161;33000.50499242562;33096.669033310325;33188.83405582957;22517.93346497025;24858.751412485643;25207.74792252054;25640;25651.35871603225 10:37:44 INFO - PROCESS | 1968 | |2;jquery.html;344.39558574701397;372.74280746285064;377.32082251946497;384.1893604494518;384.3619591478147;19754.40736777897;19855.30506432275;20107.59784804303;20625.9687015649;20640.967951602397;16465.588360291;21121;21251.6812247816;21268.361949141552;21904;5747.540196784258;6041.395860413945;6067.332593414721;6076.453119219269;6080.574359794816;4325.134973005396;4451.532589078149;5001.299818025461;6611.702473388709;6720.5550806576575;6596.80209593713;6621.271660117383;6633.170853643294;6637.004449332615;6639.867202655944;6430.742770289183;6455.128557644704;6540.4440622547145;6541.084248205255;6559.048937904001;3958.4260282259197;5483.75323110461;5636.802711905105;5716.085426331767;5717.113847353667;25120.748792512022;25317.11390101356;25437.236882893543;25560.360990975187;25619.615705764427;2207.724034495688;2265.6714776357335;2403.483251101004;2491.451880586268;2900.85495725215;15223.238838058163;15389.615259618487;15465.768013479807;15777.842221577866;16286.429974950819;1784.3754685859974;1860.8604354673453;1883.1996401529295;1896.6396384687002;1926.0562324461052;116381.41809290984;117279.24081138789;119024;121192;125613.37193314066;19657.508562286057;20052.498687532636;20178.899105504377;20203.494912627302;20237.392878213675;31074.84462577673;31119.377612447624;31510.842445788083;31751;31825.204369890937;11215.04672102864;11500.942495287638;11576.594819181288;11582.247153935135;11679;9734.561944712505;9736.659216927515;9743.366681165702;9812.460314682618;9825.919148893616;8863.468191908378;8878.334124940655;9039.81920361589;9054.411463254999;9069.229115525255;2888.638920134983;3175.3966746318124;3405.7105146062368;3470.5835299763685;3506.8093628114157;942.6842007927421;965.4448692002127;972.3048020665258;1038.445424256323;1105.9336439813637;14794.63013424673;19681.31115410954;20006.099725512388;20217.797822021592;20629.58740825205;959.3811991265594;994.2046362909643;1023.0179028133076;1040.8230600797883;1087.7661302819774;10871.021608055313;10962;11026.283291586182;11027.669169924755;11051.447427628747;626388;631834;633270;643322;645395;113676;114442;116684.66630667509;117250;122968.77031229752;1040.245821779204;1052.3685788526823;1065.9926369580671;1083.685731137977;1085.5494969587533;17646.647067058842;17833.46499605014;17853.642927141645;17904.91047544754;18634.813651863307;45292.32061519014;46099.30851037304;48580.757096215704;49835;51203.46389608318;61465.078023830574;67313;67405.3259467399;67445.97662070146;67950;7932.16712245206;7978.361731061617;8050.074241462306;8123;8127.7968050796835;11880;12739.490420383081;12955.287459189834;13174.341282936006;13217.603471895858;11007;11337.03635191018;11437.59968401102;11566.884331156582;11590.768184636428;5174.689518628894;8476.533790641328;11044;11206.159538034517;11708.238964467282;11418.600348987746;11579.8263026053;11712.88287117118;11788.587399440978;11805.645830625095;8028.43800933929;8195.303399211134;8247.298979586802;8266.958665206635;8424.452410593292;8519.787005324917;10842.674719758419;11737.178397512092;11774.587889423829;11857.051435885282 10:37:44 INFO - PROCESS | 1968 | |3;mootools.html;1520.7034628247495;1627.4466681328347;1657.301266202143;1985.811347921947;2066.33877159309;8259.793505162366;8463.19599638035;8466.788330291745;8474.491530508174;8487.660493580257;7234.49358544902;8662.393632445732;8908.955455222731;8917.063708310632;8922.553872306391;2521.508305880359;2558.5906254999204;2559.25781523358;2561.2316305108484;2564.384547708555;2490.7633774791366;2550.8979640814346;2557.8465292082533;2559.270607876746;2560;2426.7815896569305;2439.0975339124548;2447.229122826304;2448.8408253463467;2452.5708001099824;2521.3948652323493;2553.731858154895;2560.9743902561017;2564.6794150731157;2569.40903592173;2515.0945659562726;2548.286479785663;2554.9361265968314;2557.168920100956;2564.1794625719776;9101.180893719531;9168.26653867689;9177.403468774508;9201;9222.769430764285;5530.972345138289;5654.37801841797;5656.321241451011;5690.374058853523;5700.37295897451;3653.3058718843336;3722.5346831646043;3787.3182827091114;3794.146317078663;3820.4078367853026;1051.6739810658644;1075.8601381820392;1077.6336045744486;1085.5711993762498;1109.916756243277;12502.874971250261;12547.996160307244;12550.309732964683;12554.309512976783;12576;4925.75371231437;4967.006598680278;5001.899962000813;5009.223570346602;5075.847724568195;10435.895641043644;10460.843087353696;10467.528961196764;10468.947655261674;10518.421486818146;5651.604387692904;5665.49010589049;5670.149477578396;5675.602707810496;5684.34630017545;4559.088182363541;4746.477887432379;4859.902801944012;5046.217836235316;5138.460461651547;4001.379786133154;4050.3924411338535;4059.715819892638;4089;4125.690573207022;1335.7261761338902;1346.5690978886662;1346.9191848489122;1358.6331690443526;1362.1010133311966;1055.1980494823988;1076.187478453778;1218.3177420644467;1349.2241960872539;1454.1493226462426;8312.41813073079;8320.251177394064;8404.537750423786;8406.663733450716;8487.023992240847;1246.7194881151668;1254.4668515880896;1254.5483625894672;1266.265565971734;1272.840894888139;6246.3441338659695;6263.749450021948;6336.112944187817;6344.206974128234;6345.49236061114;9732.854007189897;10664.826869044398;10718.946405267923;11262.32426054423;11276.548938042386;9619;10306.587736490457;10795.730106747395;10907.945460272647;11085.889141108648;8577.571121443903;8641.827163456695;8689.73930782065;8702.042775294713;8715.651373944971;8067;8124.634391452517;8135.471194372347;8141.145179756278;8245.175482451707;9377.531123443938;9630.518474076409;9803.803923921625;9879.357841740264;9904.108630223314;10069.546870390997;10222.284440089123;10300.948495257475;10485.056344928993;10487.685369438928;7778.611069446618;7798.727044553413;7829.49108307981;7894.289513943772;7908.762737117896;8501.14988501145;8536.786580335542;8586.356023298153;8590.312774978112;8601.483910965362;6091.329953705177;7408.888866667112;7572.7728168155045;7674.347680447001;7833;7371.189169191277;7387.963060184879;7388.667509961957;7492.363149132385;7506.174320824595;7841.607919603883;7865.134835168242;7911.050673919167;7911.723089691834;7927.920720792718;7056.788296351117;7125.82185445368;7131.393831524379;7139.571625702474;7187.353138217585;7251.637418128967;7305.525140865827;7324.926750732638;7373.188949215475;7374.410047196318 10:37:44 INFO - PROCESS | 1968 | |4;prototype.html;325.77684286263906;329.7774002548279;335.60398729499184;336.52885959656476;338.56325340311014;6528.804135875931;6532.216134063913;6573.408393244607;6590.90113648295;6606.405423511889;5219.686818790875;6410.423061924426;6437.549371543993;6483.254425741041;6530.346965303467;4611.30830375443;4729.574338309551;4762.452317983424;4807.1587472192405;4882.584980276681;4719.4100737407825;4790.113828941639;4792.400949881265;4823.421189457253;4879.292502587123;4795.153865761689;4796.160671882424;4809.927851082237;4825.348577941985;4827.975860120694;4825.372701548794;4827.951720482785;4832.516748325174;4834.444038935532;4837.975810120962;3325.6508066652896;3930.253251882133;4017.4978127734034;4088.9795551022353;4132.40080188374;6169;6199.628022318675;6204.224471941007;6205.5345849061505;6227.816714824169;5609.382967873531;5617.859553511154;5618.073017952033;5619.67937534679;5621.353544342412;6914.481413893928;6914.654267286615;6919.5814857954;6927.614477104599;6931.792046238621;4579.656525760548;4594.517575654575;4596.4254468191475;4599.195140850371;4602.240630296031;6969.721211151598;7245.746398876014;7261.782146535559;7323;7327.633618319116;4437.112577484516;4508.346289787963;4515.525869783691;4523.95476045242;4526.660500462479;4598.8620341389815;4604.286335617984;4606.055758569552;4607.0785842831565;4609.976950115295;4413.801378937956;4778.808847646055;5137.948620513747;5456.645318054314;5463.863403414867;6905.516613836983;6918.308169183041;6926.722931082801;6929.099217101744;6934.687939042755;1253.8746125387388;1598.45652478158;1600.8399160084132;1603.959901002461;1605.8474444927713;874.3486102853287;997.4214955325893;1021.2902033086933;1021.4535223655308;1023.5701005577675;6175.320714721377;6256.593321434092;6285.748570057147;6378.489720822323;6409.711562979677;7160.176579693298;7188.388986936065;7196.0645116134565;7249.528780629243;7254.492185546961;5610.49505544503;6412.102305677209;6456.289808121103;6464.870702585922;6478.2873883872735;3751.5123034005405;3782.3759079751535;3784.1863999240295;3786.6402691744242;3788.962110378916;7225.1329840419485;7496;7521.586312752851;7559.622018899033;7562.810929726801;7363.042804435497;7401.296876796696;7423;7431.554106753612;7439.293267139613;6357.93642063592;6765.458763298924;7268.27317268269;7552;7589.924100758922;6535.215774107138;6561.622059367395;7221.783346499614;7265.709371625076;7266.781996540112;6837.418819400406;7057.258987806206;7067.540609860343;7071.646417678992;7109.502334836512;7470.215627359266;7503.924960750541;7525.924740752523;7548.094228692592;7563.205863384265;4553.408056952575;4611.16998940194;4624.930626040545;4625.861224163281;4628.7454190018525;7208.423326134001;7239.384652304613;7243.674034668347;7243.710251589878;7249.601271929883;6726.39462448382;6995.440364770908;7002.75490357835;7047.40097091753;7056.659234745382;6979.965100174467;7002.474814388839;7004.299570042955;7007.089078419976;7023.754168604074;6834.897476537955;6850;6853.348931851466;6854.554453960476;6879.484038697017;6986.231514533296;6987.336203060701;7015.263397343206;7036.401905838061;7037.542559733601;6614.768483103068;6621.238557565749;6789.490788191004;6803.285655006351;6869.484788640772 10:37:44 INFO - PROCESS | 1968 | |5;yui.html;640.4588123036036;705.4603228530174;763.240575627251;785.3363907498166;789.6643926331308;15380.307886145123;15609.453669121584;15621.531354059369;15678.372865085412;18032;16699;16771.496855094338;16805.32778688851;16824.579385515368;16840.747388789146;793.4921650143913;804.4087595617245;982.6855406269979;1013.7110923386837;1014.6043043213152;986.0386123529573;1006.4313662780505;1006.9496525173712;1007.415698894643;1008.9596416143346;1060.4114716332433;1065.4353192807823;1067.8184708599556;1068.1935138970066;1068.4978060311641;842.1326034184768;856.6402111113347;1012.2357619996928;1056.0179033498844;1057.1542765787378;765.9310662040388;766.0730516075555;766.6933226709305;768.3353898877486;768.8539177556303;15756.527304180892;15822.683546329008;15822.920885395615;15823.60440988973;15838.76241856373;12554.81167782484;12708.809367859489;12744.936275318563;12998.92017277231;13015.47938082485;9136.58885350161;10137.645182418653;10435.478226088666;10578.717490569768;10987.230893837435;3572.2676851245433;3600.1899572596217;3603.387424137903;3692.723045771551;3847.1151635123797;86098.56950715269;86964.8258793529;86994.5650271751;87927;89040.55479722624;9461.065880825106;9595.328327017181;9628.807423851484;9772.364796288219;9820.803583928424;22066.227682031375;22123.44691382696;22198.88900555487;22236.55526889453;22495.550088998127;7626.23737626244;7642.273983971514;7673.693052277847;7726.652300646484;7811.140774514799;4203.012292111352;4210.052738133895;4221.915561688749;4264.637505811978;4468.262736648417;3765.2657731742597;3771.792551409644;3804.543454785388;3809.9238015240094;3818.6181381861593;703.0965209705504;705.7424040225384;708.6818517557339;714.8320144765976;719.8056524738291;491.3784063160105;511.53450360172064;524.9133892907704;555.8360283716313;564.1678772561717;8312.667493300321;8330.291925186428;8413.368997325226;8520.062793092755;8595.269402100766;521.7000224870715;591.4292707537247;609.8444896551351;620.385818040137;627.2723640576909;3878.9224215515533;3917.3928041153667;3917.7257591968287;3977.2244412339314;4014.136960553495;102785;103880;105024;105616.47191763992;105869.94130058755;84651;85256.57371713225;86171.5691421539;86584;88303.55848220718;74899;75288.11779705551;75581.62209189028;75971;76840;7734.071911370672;7873.685052597832;7968.123506414174;8039.356851451753;8069.31410830086;49688.503114968385;50198.74900625474;51940.48059519356;51970.740146299024;52039;67844.6607766958;72826.90759638716;75384;76255;77060.6146969284;10057.748556286151;10235.385876847413;10327.173826094046;10486.108680762221;11033.896610338901;10589.735256618646;10715.57137714514;10832.729181770519;10973.561057557608;11114.666560003212;9317.673881414117;9966.50167491608;10274.691759247235;10657.413842238751;10798.244122911321;10625.628103016667;10641;10736.946315268373;10917.181211409335;10970.670879873616;9102.984413788363;10215.438150901475;10575;10785.191110666889;11308.717282068013;8856.202941735275;9020.86468702983;9205.171534561921;9347.719568412958;9488.810223795623;8979;9023.503707296162;9026.368154229142;9065.81868362616;9222 10:37:44 INFO - PROCESS | 1968 | __end_tp_report 10:37:44 INFO - PROCESS | 1968 | __start_cc_report 10:37:44 INFO - PROCESS | 1968 | _x_x_mozilla_cycle_collect,1004 10:37:44 INFO - PROCESS | 1968 | __end_cc_report 10:37:44 INFO - PROCESS | 1968 | __startTimestamp1460223464717__endTimestamp 10:37:44 INFO - PROCESS | 1968 | 10:37:44 INFO - PROCESS | 1968 | ------- Summary: start ------- 10:37:44 INFO - PROCESS | 1968 | Number of tests: 6 10:37:44 INFO - PROCESS | 1968 | 10:37:44 INFO - PROCESS | 1968 | [#0] dojo.html Cycles:165 Average:5738.09 Median:5985.13 stddev:631.10 (10.5%) stddev-sans-first:606.05 10:37:44 INFO - PROCESS | 1968 | Values: 3410.7 3428.5 3457.3 3460.5 3522.3 5681.3 5688.2 5689.7 5704.1 5716.7 5663.5 5716.2 5730.2 5736.8 5738.4 5102.0 5149.5 5216.4 5282.2 5292.6 5252.9 5253.4 5255.8 5256.6 5276.6 5207.6 5258.6 5261.1 5268.3 5284.4 5261.9 5302.0 5313.1 5315.5 5327.2 5062.0 5213.4 5221.8 5229.6 5264.3 5602.3 5615.5 5618.1 5649.1 5654.2 6135.2 6199.6 6201.2 6214.8 6235.4 5233.4 6104.3 6193.4 6194.3 6213.2 5819.9 5844.6 5848.2 5850.1 5850.5 6114.7 6193.6 6233.0 6233.5 6251.7 6150.2 6172.2 6180.8 6185.0 6187.2 6185.8 6188.6 6197.9 6202.9 6212.8 6039.3 6116.9 6161.5 6209.1 6222.3 6178.6 6184.6 6221.2 6227.9 6242.9 4899.3 4901.4 4911.0 4913.9 4930.0 3712.6 4348.4 4451.6 4462.4 4467.6 5679.5 5692.9 5717.3 5720.3 5796.1 6235.5 6236.0 6237.2 6238.1 6247.0 5533.1 5647.3 5680.7 5709.6 5747.8 5323.1 5342.4 5359.5 5373.6 5413.6 6322.0 6335.9 6340.9 6341.6 6354.7 6118.9 6145.0 6197.0 6200.7 6234.5 6286.7 6305.6 6340.0 6355.3 6360.3 6189.1 6198.2 6211.4 6211.4 6218.9 5910.7 6139.7 6203.8 6260.7 6298.5 6054.7 6119.3 6132.1 6135.2 6141.6 6102.9 6109.8 6141.3 6154.4 6160.4 5771.9 5921.6 5985.1 6043.8 6056.5 6107.7 6109.0 6118.1 6131.3 6139.4 5806.4 5911.2 5978.6 5989.3 6008.0 10:37:44 INFO - PROCESS | 1968 | 10:37:44 INFO - PROCESS | 1968 | [#1] ext.html Cycles:180 Average:65592.52 Median:37123.13 stddev:139997.97 (377.1%) stddev-sans-first:140305.37 10:37:44 INFO - PROCESS | 1968 | Values: 493.2 576.6 595.0 662.9 671.4 31249.5 41000.0 41022.2 41087.6 41167.6 43182.6 43808.6 43930.0 43934.6 43945.0 9651.1 9752.9 9861.4 9892.6 9896.9 8937.2 9191.8 9736.7 9909.6 9912.6 9835.2 10052.3 10059.8 10065.5 10066.7 9949.4 10037.6 10045.8 10047.0 10067.6 9802.6 9847.8 9949.0 9950.7 9963.7 42437.4 42811.8 42827.4 42862.9 42986.0 3458.8 3828.5 3891.2 3903.5 3922.3 24722.8 29552.3 29733.0 29842.7 30098.5 2448.4 2749.0 2774.9 2882.7 2901.8 461493.0 469188.0 470420.0 471231.0 471438.0 39837.4 69068.7 69179.7 69432.7 69747.7 48382.3 48542.0 48565.0 48645.0 48695.3 17220.7 17362.0 17367.2 17372.4 17388.4 13826.1 13915.3 13915.9 13916.4 13942.3 15600.5 15609.2 15691.5 15699.5 15731.9 5491.4 6611.0 6611.6 6663.3 6679.2 970.7 984.3 1008.6 1031.0 1101.2 25552.5 25574.9 30280.5 30407.5 30801.2 1146.4 1166.4 1176.4 1192.9 1204.9 13819.1 16356.8 16477.8 16567.5 16661.8 444228.0 671928.0 683947.0 684331.0 685605.0 60508.4 60867.4 61421.4 61502.4 61525.0 1209.9 1449.2 1540.6 1563.7 1682.0 30256.8 32232.2 33024.5 33089.8 33462.3 51109.0 58341.0 59370.1 59382.1 59394.0 438019.0 439334.0 441521.0 441603.0 442308.3 30086.4 33828.0 34208.7 34669.0 34744.7 41769.0 42628.6 42677.1 43431.9 43484.3 34434.8 35382.8 35559.3 35852.3 36453.5 35752.5 35814.8 36089.8 36457.9 36515.5 36566.8 36761.4 37111.4 37134.8 37296.6 31853.8 32760.5 33000.5 33096.7 33188.8 22517.9 24858.8 25207.7 25640.0 25651.4 10:37:44 INFO - PROCESS | 1968 | 10:37:44 INFO - PROCESS | 1968 | [#2] jquery.html Cycles:180 Average:36456.52 Median:13806.10 stddev:105278.31 (762.5%) stddev-sans-first:105538.73 10:37:44 INFO - PROCESS | 1968 | Values: 344.4 372.7 377.3 384.2 384.4 19754.4 19855.3 20107.6 20626.0 20641.0 16465.6 21121.0 21251.7 21268.4 21904.0 5747.5 6041.4 6067.3 6076.5 6080.6 4325.1 4451.5 5001.3 6611.7 6720.6 6596.8 6621.3 6633.2 6637.0 6639.9 6430.7 6455.1 6540.4 6541.1 6559.0 3958.4 5483.8 5636.8 5716.1 5717.1 25120.7 25317.1 25437.2 25560.4 25619.6 2207.7 2265.7 2403.5 2491.5 2900.9 15223.2 15389.6 15465.8 15777.8 16286.4 1784.4 1860.9 1883.2 1896.6 1926.1 116381.4 117279.2 119024.0 121192.0 125613.4 19657.5 20052.5 20178.9 20203.5 20237.4 31074.8 31119.4 31510.8 31751.0 31825.2 11215.0 11500.9 11576.6 11582.2 11679.0 9734.6 9736.7 9743.4 9812.5 9825.9 8863.5 8878.3 9039.8 9054.4 9069.2 2888.6 3175.4 3405.7 3470.6 3506.8 942.7 965.4 972.3 1038.4 1105.9 14794.6 19681.3 20006.1 20217.8 20629.6 959.4 994.2 1023.0 1040.8 1087.8 10871.0 10962.0 11026.3 11027.7 11051.4 626388.0 631834.0 633270.0 643322.0 645395.0 113676.0 114442.0 116684.7 117250.0 122968.8 1040.2 1052.4 1066.0 1083.7 1085.5 17646.6 17833.5 17853.6 17904.9 18634.8 45292.3 46099.3 48580.8 49835.0 51203.5 61465.1 67313.0 67405.3 67446.0 67950.0 7932.2 7978.4 8050.1 8123.0 8127.8 11880.0 12739.5 12955.3 13174.3 13217.6 11007.0 11337.0 11437.6 11566.9 11590.8 5174.7 8476.5 11044.0 11206.2 11708.2 11418.6 11579.8 11712.9 11788.6 11805.6 8028.4 8195.3 8247.3 8267.0 8424.5 8519.8 10842.7 11737.2 11774.6 11857.1 10:37:44 INFO - PROCESS | 1968 | 10:37:44 INFO - PROCESS | 1968 | [#3] mootools.html Cycles:180 Average:6216.38 Median:5061.03 stddev:3253.56 (64.3%) stddev-sans-first:3243.54 10:37:44 INFO - PROCESS | 1968 | Values: 1520.7 1627.4 1657.3 1985.8 2066.3 8259.8 8463.2 8466.8 8474.5 8487.7 7234.5 8662.4 8909.0 8917.1 8922.6 2521.5 2558.6 2559.3 2561.2 2564.4 2490.8 2550.9 2557.8 2559.3 2560.0 2426.8 2439.1 2447.2 2448.8 2452.6 2521.4 2553.7 2561.0 2564.7 2569.4 2515.1 2548.3 2554.9 2557.2 2564.2 9101.2 9168.3 9177.4 9201.0 9222.8 5531.0 5654.4 5656.3 5690.4 5700.4 3653.3 3722.5 3787.3 3794.1 3820.4 1051.7 1075.9 1077.6 1085.6 1109.9 12502.9 12548.0 12550.3 12554.3 12576.0 4925.8 4967.0 5001.9 5009.2 5075.8 10435.9 10460.8 10467.5 10468.9 10518.4 5651.6 5665.5 5670.1 5675.6 5684.3 4559.1 4746.5 4859.9 5046.2 5138.5 4001.4 4050.4 4059.7 4089.0 4125.7 1335.7 1346.6 1346.9 1358.6 1362.1 1055.2 1076.2 1218.3 1349.2 1454.1 8312.4 8320.3 8404.5 8406.7 8487.0 1246.7 1254.5 1254.5 1266.3 1272.8 6246.3 6263.7 6336.1 6344.2 6345.5 9732.9 10664.8 10718.9 11262.3 11276.5 9619.0 10306.6 10795.7 10907.9 11085.9 8577.6 8641.8 8689.7 8702.0 8715.7 8067.0 8124.6 8135.5 8141.1 8245.2 9377.5 9630.5 9803.8 9879.4 9904.1 10069.5 10222.3 10300.9 10485.1 10487.7 7778.6 7798.7 7829.5 7894.3 7908.8 8501.1 8536.8 8586.4 8590.3 8601.5 6091.3 7408.9 7572.8 7674.3 7833.0 7371.2 7388.0 7388.7 7492.4 7506.2 7841.6 7865.1 7911.1 7911.7 7927.9 7056.8 7125.8 7131.4 7139.6 7187.4 7251.6 7305.5 7324.9 7373.2 7374.4 10:37:44 INFO - PROCESS | 1968 | 10:37:44 INFO - PROCESS | 1968 | [#4] prototype.html Cycles:180 Average:5663.51 Median:6471.58 stddev:1824.51 (28.2%) stddev-sans-first:1785.10 10:37:44 INFO - PROCESS | 1968 | Values: 325.8 329.8 335.6 336.5 338.6 6528.8 6532.2 6573.4 6590.9 6606.4 5219.7 6410.4 6437.5 6483.3 6530.3 4611.3 4729.6 4762.5 4807.2 4882.6 4719.4 4790.1 4792.4 4823.4 4879.3 4795.2 4796.2 4809.9 4825.3 4828.0 4825.4 4828.0 4832.5 4834.4 4838.0 3325.7 3930.3 4017.5 4089.0 4132.4 6169.0 6199.6 6204.2 6205.5 6227.8 5609.4 5617.9 5618.1 5619.7 5621.4 6914.5 6914.7 6919.6 6927.6 6931.8 4579.7 4594.5 4596.4 4599.2 4602.2 6969.7 7245.7 7261.8 7323.0 7327.6 4437.1 4508.3 4515.5 4524.0 4526.7 4598.9 4604.3 4606.1 4607.1 4610.0 4413.8 4778.8 5137.9 5456.6 5463.9 6905.5 6918.3 6926.7 6929.1 6934.7 1253.9 1598.5 1600.8 1604.0 1605.8 874.3 997.4 1021.3 1021.5 1023.6 6175.3 6256.6 6285.7 6378.5 6409.7 7160.2 7188.4 7196.1 7249.5 7254.5 5610.5 6412.1 6456.3 6464.9 6478.3 3751.5 3782.4 3784.2 3786.6 3789.0 7225.1 7496.0 7521.6 7559.6 7562.8 7363.0 7401.3 7423.0 7431.6 7439.3 6357.9 6765.5 7268.3 7552.0 7589.9 6535.2 6561.6 7221.8 7265.7 7266.8 6837.4 7057.3 7067.5 7071.6 7109.5 7470.2 7503.9 7525.9 7548.1 7563.2 4553.4 4611.2 4624.9 4625.9 4628.7 7208.4 7239.4 7243.7 7243.7 7249.6 6726.4 6995.4 7002.8 7047.4 7056.7 6980.0 7002.5 7004.3 7007.1 7023.8 6834.9 6850.0 6853.3 6854.6 6879.5 6986.2 6987.3 7015.3 7036.4 7037.5 6614.8 6621.2 6789.5 6803.3 6869.5 10:37:44 INFO - PROCESS | 1968 | 10:37:44 INFO - PROCESS | 1968 | [#5] yui.html Cycles:180 Average:19459.12 Median:25089.94 stddev:28383.77 (113.1%) stddev-sans-first:28428.22 10:37:44 INFO - PROCESS | 1968 | Values: 640.5 705.5 763.2 785.3 789.7 15380.3 15609.5 15621.5 15678.4 18032.0 16699.0 16771.5 16805.3 16824.6 16840.7 793.5 804.4 982.7 1013.7 1014.6 986.0 1006.4 1006.9 1007.4 1009.0 1060.4 1065.4 1067.8 1068.2 1068.5 842.1 856.6 1012.2 1056.0 1057.2 765.9 766.1 766.7 768.3 768.9 15756.5 15822.7 15822.9 15823.6 15838.8 12554.8 12708.8 12744.9 12998.9 13015.5 9136.6 10137.6 10435.5 10578.7 10987.2 3572.3 3600.2 3603.4 3692.7 3847.1 86098.6 86964.8 86994.6 87927.0 89040.6 9461.1 9595.3 9628.8 9772.4 9820.8 22066.2 22123.4 22198.9 22236.6 22495.6 7626.2 7642.3 7673.7 7726.7 7811.1 4203.0 4210.1 4221.9 4264.6 4468.3 3765.3 3771.8 3804.5 3809.9 3818.6 703.1 705.7 708.7 714.8 719.8 491.4 511.5 524.9 555.8 564.2 8312.7 8330.3 8413.4 8520.1 8595.3 521.7 591.4 609.8 620.4 627.3 3878.9 3917.4 3917.7 3977.2 4014.1 102785.0 103880.0 105024.0 105616.5 105869.9 84651.0 85256.6 86171.6 86584.0 88303.6 74899.0 75288.1 75581.6 75971.0 76840.0 7734.1 7873.7 7968.1 8039.4 8069.3 49688.5 50198.7 51940.5 51970.7 52039.0 67844.7 72826.9 75384.0 76255.0 77060.6 10057.7 10235.4 10327.2 10486.1 11033.9 10589.7 10715.6 10832.7 10973.6 11114.7 9317.7 9966.5 10274.7 10657.4 10798.2 10625.6 10641.0 10736.9 10917.2 10970.7 9103.0 10215.4 10575.0 10785.2 11308.7 8856.2 9020.9 9205.2 9347.7 9488.8 8979.0 9023.5 9026.4 9065.8 9222.0 10:37:44 INFO - PROCESS | 1968 | -------- Summary: end -------- 10:37:44 INFO - PROCESS | 1968 | 10:37:45 INFO - TEST-INFO | 1968: exit 0 10:37:45 INFO - TEST-OK | dromaeo_css | took 1112891ms 10:37:45 INFO - TEST-START | kraken 10:37:45 INFO - operating with platform_type : mac_ 10:37:45 INFO - Initialising browser for kraken test... 10:37:45 INFO - TEST-INFO | started process 1973 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmphn6PS3/profile http://localhost:49486/getInfo.html) 10:37:47 INFO - PROCESS | 1973 | __metrics Screen width/height:1600/1200 10:37:47 INFO - PROCESS | 1973 | colorDepth:24 10:37:47 INFO - PROCESS | 1973 | Browser inner width/height: 1024/689 10:37:47 INFO - PROCESS | 1973 | __metrics 10:37:47 INFO - PROCESS | 1973 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:37:47 INFO - PROCESS | 1973 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:37:48 INFO - TEST-INFO | 1973: exit 0 10:37:48 INFO - Browser initialized. 10:37:48 INFO - Running cycle 1/1 for kraken test... 10:37:48 INFO - TEST-INFO | started process 1975 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmphn6PS3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:37:59 INFO - PROCESS | 1975 | RSS: Main: 207413248 10:37:59 INFO - PROCESS | 1975 | 10:38:02 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49486/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49486/tests/kraken/driver.html?testName=audio-beat-detection) 10:38:03 INFO - PROCESS | 1975 | RSS: Main: 263401472 10:38:03 INFO - PROCESS | 1975 | 10:38:05 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49486/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49486/tests/kraken/driver.html?testName=audio-dft) 10:38:06 INFO - PROCESS | 1975 | RSS: Main: 273281024 10:38:06 INFO - PROCESS | 1975 | 10:38:09 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49486/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49486/tests/kraken/driver.html?testName=audio-fft) 10:38:10 INFO - PROCESS | 1975 | RSS: Main: 262455296 10:38:10 INFO - PROCESS | 1975 | 10:38:12 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49486/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49486/tests/kraken/driver.html?testName=audio-oscillator) 10:38:12 INFO - PROCESS | 1975 | RSS: Main: 264847360 10:38:12 INFO - PROCESS | 1975 | 10:38:14 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49486/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49486/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:38:15 INFO - PROCESS | 1975 | RSS: Main: 264740864 10:38:15 INFO - PROCESS | 1975 | 10:38:18 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49486/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49486/tests/kraken/driver.html?testName=imaging-darkroom) 10:38:18 INFO - PROCESS | 1975 | RSS: Main: 265285632 10:38:18 INFO - PROCESS | 1975 | 10:38:21 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49486/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49486/tests/kraken/driver.html?testName=imaging-desaturate) 10:38:22 INFO - PROCESS | 1975 | RSS: Main: 265187328 10:38:22 INFO - PROCESS | 1975 | 10:38:24 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49486/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49486/tests/kraken/driver.html?testName=json-parse-financial) 10:38:25 INFO - PROCESS | 1975 | RSS: Main: 265568256 10:38:25 INFO - PROCESS | 1975 | 10:38:27 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49486/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49486/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:38:27 INFO - PROCESS | 1975 | RSS: Main: 299761664 10:38:27 INFO - PROCESS | 1975 | 10:38:29 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49486/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49486/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:38:30 INFO - PROCESS | 1975 | RSS: Main: 300613632 10:38:30 INFO - PROCESS | 1975 | 10:38:32 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49486/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49486/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:38:32 INFO - PROCESS | 1975 | RSS: Main: 305770496 10:38:32 INFO - PROCESS | 1975 | 10:38:35 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49486/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49486/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:38:36 INFO - PROCESS | 1975 | RSS: Main: 307617792 10:38:36 INFO - PROCESS | 1975 | 10:38:38 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49486/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49486/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:38:39 INFO - PROCESS | 1975 | RSS: Main: 307662848 10:38:39 INFO - PROCESS | 1975 | 10:38:40 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49486/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49486/tests/kraken/driver.html?testName=ai-astar) 10:38:41 INFO - PROCESS | 1975 | RSS: Main: 369680384 10:38:41 INFO - PROCESS | 1975 | 10:38:41 INFO - PROCESS | 1975 | __start_tp_report 10:38:41 INFO - PROCESS | 1975 | _x_x_mozilla_page_load 10:38:41 INFO - PROCESS | 1975 | _x_x_mozilla_page_load_details 10:38:41 INFO - PROCESS | 1975 | |i|pagename|runs| 10:38:41 INFO - PROCESS | 1975 | |0;ai-astar;112;107;111;110;111;112;121;111;109;109 10:38:41 INFO - PROCESS | 1975 | |1;audio-beat-detection;179;151;140;153;118;135;116;150;148;116 10:38:41 INFO - PROCESS | 1975 | |2;audio-dft;184;186;184;185;185;183;184;186;185;185 10:38:41 INFO - PROCESS | 1975 | |3;audio-fft;73;72;76;119;55;57;60;58;120;77 10:38:41 INFO - PROCESS | 1975 | |4;audio-oscillator;91;95;128;112;97;82;121;76;77;122 10:38:41 INFO - PROCESS | 1975 | |5;imaging-gaussian-blur;87;85;88;85;87;84;87;86;87;85 10:38:41 INFO - PROCESS | 1975 | |6;imaging-darkroom;92;93;93;94;93;93;94;94;92;93 10:38:41 INFO - PROCESS | 1975 | |7;imaging-desaturate;125;144;84;84;86;86;88;87;86;87 10:38:41 INFO - PROCESS | 1975 | |8;json-parse-financial;54;58;58;58;58;58;57;67;55;52 10:38:41 INFO - PROCESS | 1975 | |9;json-stringify-tinderbox;61;66;102;99;108;69;68;66;65;65 10:38:41 INFO - PROCESS | 1975 | |10;stanford-crypto-aes;79;101;81;81;81;80;81;77;94;111 10:38:41 INFO - PROCESS | 1975 | |11;stanford-crypto-ccm;121;119;128;117;116;130;124;129;131;117 10:38:41 INFO - PROCESS | 1975 | |12;stanford-crypto-pbkdf2;134;124;133;133;133;120;130;133;132;132 10:38:41 INFO - PROCESS | 1975 | |13;stanford-crypto-sha256-iterative;65;67;67;90;99;97;80;65;66;64 10:38:41 INFO - PROCESS | 1975 | __end_tp_report 10:38:41 INFO - PROCESS | 1975 | __start_cc_report 10:38:41 INFO - PROCESS | 1975 | _x_x_mozilla_cycle_collect,1200 10:38:41 INFO - PROCESS | 1975 | __end_cc_report 10:38:41 INFO - PROCESS | 1975 | __startTimestamp1460223521085__endTimestamp 10:38:41 INFO - PROCESS | 1975 | 10:38:41 INFO - PROCESS | 1975 | ------- Summary: start ------- 10:38:41 INFO - PROCESS | 1975 | Number of tests: 14 10:38:41 INFO - PROCESS | 1975 | 10:38:41 INFO - PROCESS | 1975 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:3.74 (3.4%) stddev-sans-first:3.96 10:38:41 INFO - PROCESS | 1975 | Values: 112.0 107.0 111.0 110.0 111.0 112.0 121.0 111.0 109.0 109.0 10:38:41 INFO - PROCESS | 1975 | 10:38:41 INFO - PROCESS | 1975 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:149.00 stddev:20.09 (13.5%) stddev-sans-first:15.79 10:38:41 INFO - PROCESS | 1975 | Values: 179.0 151.0 140.0 153.0 118.0 135.0 116.0 150.0 148.0 116.0 10:38:41 INFO - PROCESS | 1975 | 10:38:41 INFO - PROCESS | 1975 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.00 stddev:0.95 (0.5%) stddev-sans-first:0.97 10:38:41 INFO - PROCESS | 1975 | Values: 184.0 186.0 184.0 185.0 185.0 183.0 184.0 186.0 185.0 185.0 10:38:41 INFO - PROCESS | 1975 | 10:38:41 INFO - PROCESS | 1975 | [#3] audio-fft Cycles:10 Average:76.70 Median:66.00 stddev:24.01 (36.4%) stddev-sans-first:25.43 10:38:41 INFO - PROCESS | 1975 | Values: 73.0 72.0 76.0 119.0 55.0 57.0 60.0 58.0 120.0 77.0 10:38:41 INFO - PROCESS | 1975 | 10:38:41 INFO - PROCESS | 1975 | [#4] audio-oscillator Cycles:10 Average:100.10 Median:79.50 stddev:19.43 (24.4%) stddev-sans-first:20.33 10:38:41 INFO - PROCESS | 1975 | Values: 91.0 95.0 128.0 112.0 97.0 82.0 121.0 76.0 77.0 122.0 10:38:41 INFO - PROCESS | 1975 | 10:38:41 INFO - PROCESS | 1975 | [#5] imaging-gaussian-blur Cycles:10 Average:86.10 Median:87.00 stddev:1.29 (1.5%) stddev-sans-first:1.32 10:38:41 INFO - PROCESS | 1975 | Values: 87.0 85.0 88.0 85.0 87.0 84.0 87.0 86.0 87.0 85.0 10:38:41 INFO - PROCESS | 1975 | 10:38:41 INFO - PROCESS | 1975 | [#6] imaging-darkroom Cycles:10 Average:93.10 Median:93.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 10:38:41 INFO - PROCESS | 1975 | Values: 92.0 93.0 93.0 94.0 93.0 93.0 94.0 94.0 92.0 93.0 10:38:41 INFO - PROCESS | 1975 | 10:38:41 INFO - PROCESS | 1975 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:86.00 stddev:20.97 (24.4%) stddev-sans-first:19.38 10:38:41 INFO - PROCESS | 1975 | Values: 125.0 144.0 84.0 84.0 86.0 86.0 88.0 87.0 86.0 87.0 10:38:41 INFO - PROCESS | 1975 | 10:38:41 INFO - PROCESS | 1975 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:58.00 stddev:3.95 (6.8%) stddev-sans-first:3.98 10:38:41 INFO - PROCESS | 1975 | Values: 54.0 58.0 58.0 58.0 58.0 58.0 57.0 67.0 55.0 52.0 10:38:41 INFO - PROCESS | 1975 | 10:38:41 INFO - PROCESS | 1975 | [#9] json-stringify-tinderbox Cycles:10 Average:76.90 Median:66.00 stddev:18.26 (27.7%) stddev-sans-first:18.44 10:38:41 INFO - PROCESS | 1975 | Values: 61.0 66.0 102.0 99.0 108.0 69.0 68.0 66.0 65.0 65.0 10:38:41 INFO - PROCESS | 1975 | 10:38:41 INFO - PROCESS | 1975 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:81.00 stddev:11.43 (14.1%) stddev-sans-first:11.79 10:38:41 INFO - PROCESS | 1975 | Values: 79.0 101.0 81.0 81.0 81.0 80.0 81.0 77.0 94.0 111.0 10:38:41 INFO - PROCESS | 1975 | 10:38:41 INFO - PROCESS | 1975 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:126.00 stddev:5.92 (4.7%) stddev-sans-first:6.23 10:38:41 INFO - PROCESS | 1975 | Values: 121.0 119.0 128.0 117.0 116.0 130.0 124.0 129.0 131.0 117.0 10:38:41 INFO - PROCESS | 1975 | 10:38:41 INFO - PROCESS | 1975 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:130.40 Median:133.00 stddev:4.65 (3.5%) stddev-sans-first:4.74 10:38:41 INFO - PROCESS | 1975 | Values: 134.0 124.0 133.0 133.0 133.0 120.0 130.0 133.0 132.0 132.0 10:38:41 INFO - PROCESS | 1975 | 10:38:41 INFO - PROCESS | 1975 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.00 Median:73.50 stddev:14.26 (19.4%) stddev-sans-first:14.56 10:38:41 INFO - PROCESS | 1975 | Values: 65.0 67.0 67.0 90.0 99.0 97.0 80.0 65.0 66.0 64.0 10:38:41 INFO - PROCESS | 1975 | -------- Summary: end -------- 10:38:41 INFO - PROCESS | 1975 | 10:38:41 INFO - TEST-INFO | 1975: exit 0 10:38:41 INFO - TEST-OK | kraken | took 56472ms 10:38:41 INFO - SUITE-END | took 1169s 10:38:42 INFO - Completed test suite (00:19:29) 10:38:42 INFO - javascript benchmark 10:38:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3410.675985781351, 3428.4857271409287, 3457.273972465782, 3460.515527826104, 3522.2955408918206, 5681.318241810978, 5688.232088668028, 5689.658620482764, 5704.087346024637, 5716.742746576404, 5663.546916246701, 5716.199732037508, 5730.169125476803, 5736.799212027579, 5738.42615738427, 5102.0, 5149.459306772791, 5216.400113986892, 5282.181261904392, 5292.603054770908, 5252.894942101156, 5253.44838791927, 5255.763490642911, 5256.605754568403, 5276.630635855492, 5207.6354655174155, 5258.579313654917, 5261.105612045962, 5268.262443257947, 5284.39229488608, 5261.86845328866, 5302.019126461617, 5313.149896016657, 5315.468453154692, 5327.200919862013, 5061.974690126526, 5213.4004589472315, 5221.765020574083, 5229.633925625208, 5264.341957255343, 5602.271704678406, 5615.522680572156, 5618.073017952033, 5649.12438572022, 5654.236678048493, 6135.202423684892, 6199.597026193283, 6201.162843016225, 6214.8135555933395, 6235.376462353774, 5233.4243233244315, 6104.267487901436, 6193.4425901669065, 6194.287656919467, 6213.2233470816145, 5819.854503637401, 5844.561657875676, 5848.210491583667, 5850.122481627747, 5850.5027072699295, 6114.663693496811, 6193.628382297076, 6232.968835155886, 6233.470155036873, 6251.6561589113035, 6150.169727086875, 6172.197614310111, 6180.81457556274, 6185.010398336244, 6187.16473276111, 6185.752569897244, 6188.628682278988, 6197.938020619736, 6202.937970620236, 6212.844678883064, 6039.305479869783, 6116.866227185065, 6161.507079433634, 6209.130721698965, 6222.3466536013975, 6178.598391104564, 6184.5980011299125, 6221.191245138193, 6227.9377206227355, 6242.906356404657, 4899.314096026559, 4901.43633482147, 4910.999999999928, 4913.852584422473, 4929.950700493021, 3712.6472985066375, 4348.391225228471, 4451.621612162938, 4462.352958820953, 4467.6202522785925, 5679.517241034476, 5692.857678558069, 5717.256756621696, 5720.256366672389, 5796.072628379439, 6235.501159907287, 6235.96882015587, 6237.1891654084675, 6238.1266622672865, 6247.031710084853, 5533.114701647717, 5647.322321321386, 5680.715964201773, 5709.628874123168, 5747.770089196469, 5323.0950738373795, 5342.439043900412, 5359.490848369399, 5373.623846330797, 5413.566914646897, 6322.0, 6335.873282534231, 6340.873182536324, 6341.619502829845, 6354.745810167634, 6118.923762351665, 6145.033589251575, 6197.03945888388, 6200.689965501617, 6234.501239900887, 6286.748530058747, 6305.5901366411035, 6340.0, 6355.332690067661, 6360.300366959723, 6189.071639254148, 6198.2252218472695, 6211.378862113753, 6211.440970312694, 6218.906716399348, 5910.7340169693325, 6139.676133582418, 6203.844903877439, 6260.655663938527, 6298.496120310272, 6054.697265136813, 6119.296280927751, 6132.141500190066, 6135.233095863017, 6141.570090093651, 6102.908456373069, 6109.75560977556, 6141.263048434216, 6154.3845615438095, 6160.44555989963, 5771.913421298768, 5921.644701317935, 5985.132155837292, 6043.758249669964, 6056.515478761777, 6107.67434349443, 6108.969455152695, 6118.05942802523, 6131.321207275599, 6139.416755408229, 5806.419358064329, 5911.231539899785, 5978.581499295007, 5989.2812862456785, 6008.03871380577], "unit": "score", "name": "dojo.html", "value": 5698.163058900474}, {"lowerIsBetter": false, "replicates": [493.2305603258914, 576.6050255574931, 595.027130641401, 662.903878937554, 671.4158681946707, 31249.531257031133, 40999.975000624996, 41022.17955640885, 41087.58912410875, 41167.58832411675, 43182.56817431825, 43808.56191438084, 43930.0, 43934.56065439345, 43945.0, 9651.131398174146, 9752.902470975307, 9861.408315501058, 9892.604295828158, 9896.851547226797, 8937.240334571568, 9191.770205744877, 9736.659216927408, 9909.603615855358, 9912.603495860158, 9835.213182945383, 10052.296339256254, 10059.798804023914, 10065.547050382715, 10066.69799906004, 9949.403035817837, 10037.598496060149, 10045.799084018352, 10047.0, 10067.647632332833, 9802.607895684236, 9847.753806154831, 9949.0, 9950.701478955643, 9963.70108896727, 42437.36343954843, 42811.7859410701, 42827.35758963618, 42862.928426789265, 42986.0, 3458.792472451661, 3828.540575130974, 3891.20230352777, 3903.531576210873, 3922.293987082324, 24722.752772472406, 29552.26119347012, 29733.0, 29842.70157298421, 30098.54852177219, 2448.4490989527394, 2748.9862550687317, 2774.9445011099665, 2882.654081510211, 2901.7533509651703, 461493.0, 469187.99999999657, 470420.0, 471231.0, 471438.0, 39837.402438963436, 69068.6546567264, 69179.65410172917, 69432.65283673651, 69747.65126174336, 48382.27426588604, 48542.0, 48565.0, 48645.0, 48695.269570956465, 17220.741688874426, 17362.0, 17367.218475168647, 17372.39196628112, 17388.391406300972, 13826.101303415246, 13915.30423478822, 13915.860841391659, 13916.443342266399, 13942.302884855717, 15600.453984110729, 15609.219539023003, 15691.450799221973, 15699.450519231772, 15731.921340393454, 5491.423400542965, 6611.0, 6611.603303801788, 6663.301362948014, 6679.165104361955, 970.7184916374173, 984.3257368702461, 1008.5915204342253, 1030.9639162629271, 1101.1906248907046, 25552.48895022089, 25574.872125639624, 30280.54579181314, 30407.543886841715, 30801.229969250948, 1146.3866831245243, 1166.3585028234438, 1176.3588844079998, 1192.928424294545, 1204.873488283735, 13819.090454772613, 16356.754648680278, 16477.752833707505, 16567.50297491077, 16661.750073748903, 444228.0, 671928.0, 683947.0, 684331.0, 685605.0, 60508.394916051155, 60867.39132608706, 61421.38578614246, 61502.38497615056, 61525.0, 1209.909256805743, 1449.2101804516353, 1540.6456515001612, 1563.7185306644913, 1681.991590042042, 30256.84871575628, 32232.19419514531, 33024.50463243005, 33089.834550827094, 33462.330753385286, 51109.0, 58341.0, 59370.10944835745, 59382.10926836187, 59394.0, 438019.0, 439334.0, 441521.0, 441603.0, 442308.30766770255, 30086.398272034, 33828.0, 34208.657913420546, 34669.0, 34744.652553474145, 41769.0, 42628.5737142637, 42677.14645707131, 43431.9142021452, 43484.34773478337, 34434.82782586071, 35382.8230858844, 35559.288814224084, 35852.28295434129, 36453.45319820152, 35752.463713043806, 35814.820925895205, 36089.81955090313, 36457.90626281216, 36515.452268215464, 36566.817165914, 36761.448578270814, 37111.44332835064, 37134.8143259282, 37296.62703372932, 31853.840730796197, 32760.50859237161, 33000.50499242562, 33096.669033310325, 33188.83405582957, 22517.93346497025, 24858.751412485643, 25207.74792252054, 25640.0, 25651.35871603225], "unit": "score", "name": "ext.html", "value": 19942.966792890747}, {"lowerIsBetter": false, "replicates": [344.39558574701397, 372.74280746285064, 377.32082251946497, 384.1893604494518, 384.3619591478147, 19754.40736777897, 19855.30506432275, 20107.59784804303, 20625.9687015649, 20640.967951602397, 16465.588360291, 21121.0, 21251.6812247816, 21268.361949141552, 21904.0, 5747.540196784258, 6041.395860413945, 6067.332593414721, 6076.453119219269, 6080.574359794816, 4325.134973005396, 4451.532589078149, 5001.299818025461, 6611.702473388709, 6720.5550806576575, 6596.80209593713, 6621.271660117383, 6633.170853643294, 6637.004449332615, 6639.867202655944, 6430.742770289183, 6455.128557644704, 6540.4440622547145, 6541.084248205255, 6559.048937904001, 3958.4260282259197, 5483.75323110461, 5636.802711905105, 5716.085426331767, 5717.113847353667, 25120.748792512022, 25317.11390101356, 25437.236882893543, 25560.360990975187, 25619.615705764427, 2207.724034495688, 2265.6714776357335, 2403.483251101004, 2491.451880586268, 2900.85495725215, 15223.238838058163, 15389.615259618487, 15465.768013479807, 15777.842221577866, 16286.429974950819, 1784.3754685859974, 1860.8604354673453, 1883.1996401529295, 1896.6396384687002, 1926.0562324461052, 116381.41809290984, 117279.24081138789, 119024.0, 121192.0, 125613.37193314066, 19657.508562286057, 20052.498687532636, 20178.899105504377, 20203.494912627302, 20237.392878213675, 31074.84462577673, 31119.377612447624, 31510.842445788083, 31751.0, 31825.204369890937, 11215.04672102864, 11500.942495287638, 11576.594819181288, 11582.247153935135, 11679.0, 9734.561944712505, 9736.659216927515, 9743.366681165702, 9812.460314682618, 9825.919148893616, 8863.468191908378, 8878.334124940655, 9039.81920361589, 9054.411463254999, 9069.229115525255, 2888.638920134983, 3175.3966746318124, 3405.7105146062368, 3470.5835299763685, 3506.8093628114157, 942.6842007927421, 965.4448692002127, 972.3048020665258, 1038.445424256323, 1105.9336439813637, 14794.63013424673, 19681.31115410954, 20006.099725512388, 20217.797822021592, 20629.58740825205, 959.3811991265594, 994.2046362909643, 1023.0179028133076, 1040.8230600797883, 1087.7661302819774, 10871.021608055313, 10962.0, 11026.283291586182, 11027.669169924755, 11051.447427628747, 626388.0, 631834.0, 633270.0, 643322.0, 645395.0, 113676.0, 114442.0, 116684.66630667509, 117250.0, 122968.77031229752, 1040.245821779204, 1052.3685788526823, 1065.9926369580671, 1083.685731137977, 1085.5494969587533, 17646.647067058842, 17833.46499605014, 17853.642927141645, 17904.91047544754, 18634.813651863307, 45292.32061519014, 46099.30851037304, 48580.757096215704, 49835.0, 51203.46389608318, 61465.078023830574, 67313.0, 67405.3259467399, 67445.97662070146, 67950.0, 7932.16712245206, 7978.361731061617, 8050.074241462306, 8123.0, 8127.7968050796835, 11880.0, 12739.490420383081, 12955.287459189834, 13174.341282936006, 13217.603471895858, 11007.0, 11337.03635191018, 11437.59968401102, 11566.884331156582, 11590.768184636428, 5174.689518628894, 8476.533790641328, 11044.0, 11206.159538034517, 11708.238964467282, 11418.600348987746, 11579.8263026053, 11712.88287117118, 11788.587399440978, 11805.645830625095, 8028.43800933929, 8195.303399211134, 8247.298979586802, 8266.958665206635, 8424.452410593292, 8519.787005324917, 10842.674719758419, 11737.178397512092, 11774.587889423829, 11857.051435885282], "unit": "score", "name": "jquery.html", "value": 10512.464452873131}, {"lowerIsBetter": false, "replicates": [1520.7034628247495, 1627.4466681328347, 1657.301266202143, 1985.811347921947, 2066.33877159309, 8259.793505162366, 8463.19599638035, 8466.788330291745, 8474.491530508174, 8487.660493580257, 7234.49358544902, 8662.393632445732, 8908.955455222731, 8917.063708310632, 8922.553872306391, 2521.508305880359, 2558.5906254999204, 2559.25781523358, 2561.2316305108484, 2564.384547708555, 2490.7633774791366, 2550.8979640814346, 2557.8465292082533, 2559.270607876746, 2560.0, 2426.7815896569305, 2439.0975339124548, 2447.229122826304, 2448.8408253463467, 2452.5708001099824, 2521.3948652323493, 2553.731858154895, 2560.9743902561017, 2564.6794150731157, 2569.40903592173, 2515.0945659562726, 2548.286479785663, 2554.9361265968314, 2557.168920100956, 2564.1794625719776, 9101.180893719531, 9168.26653867689, 9177.403468774508, 9201.0, 9222.769430764285, 5530.972345138289, 5654.37801841797, 5656.321241451011, 5690.374058853523, 5700.37295897451, 3653.3058718843336, 3722.5346831646043, 3787.3182827091114, 3794.146317078663, 3820.4078367853026, 1051.6739810658644, 1075.8601381820392, 1077.6336045744486, 1085.5711993762498, 1109.916756243277, 12502.874971250261, 12547.996160307244, 12550.309732964683, 12554.309512976783, 12576.0, 4925.75371231437, 4967.006598680278, 5001.899962000813, 5009.223570346602, 5075.847724568195, 10435.895641043644, 10460.843087353696, 10467.528961196764, 10468.947655261674, 10518.421486818146, 5651.604387692904, 5665.49010589049, 5670.149477578396, 5675.602707810496, 5684.34630017545, 4559.088182363541, 4746.477887432379, 4859.902801944012, 5046.217836235316, 5138.460461651547, 4001.379786133154, 4050.3924411338535, 4059.715819892638, 4089.0, 4125.690573207022, 1335.7261761338902, 1346.5690978886662, 1346.9191848489122, 1358.6331690443526, 1362.1010133311966, 1055.1980494823988, 1076.187478453778, 1218.3177420644467, 1349.2241960872539, 1454.1493226462426, 8312.41813073079, 8320.251177394064, 8404.537750423786, 8406.663733450716, 8487.023992240847, 1246.7194881151668, 1254.4668515880896, 1254.5483625894672, 1266.265565971734, 1272.840894888139, 6246.3441338659695, 6263.749450021948, 6336.112944187817, 6344.206974128234, 6345.49236061114, 9732.854007189897, 10664.826869044398, 10718.946405267923, 11262.32426054423, 11276.548938042386, 9619.0, 10306.587736490457, 10795.730106747395, 10907.945460272647, 11085.889141108648, 8577.571121443903, 8641.827163456695, 8689.73930782065, 8702.042775294713, 8715.651373944971, 8067.0, 8124.634391452517, 8135.471194372347, 8141.145179756278, 8245.175482451707, 9377.531123443938, 9630.518474076409, 9803.803923921625, 9879.357841740264, 9904.108630223314, 10069.546870390997, 10222.284440089123, 10300.948495257475, 10485.056344928993, 10487.685369438928, 7778.611069446618, 7798.727044553413, 7829.49108307981, 7894.289513943772, 7908.762737117896, 8501.14988501145, 8536.786580335542, 8586.356023298153, 8590.312774978112, 8601.483910965362, 6091.329953705177, 7408.888866667112, 7572.7728168155045, 7674.347680447001, 7833.0, 7371.189169191277, 7387.963060184879, 7388.667509961957, 7492.363149132385, 7506.174320824595, 7841.607919603883, 7865.134835168242, 7911.050673919167, 7911.723089691834, 7927.920720792718, 7056.788296351117, 7125.82185445368, 7131.393831524379, 7139.571625702474, 7187.353138217585, 7251.637418128967, 7305.525140865827, 7324.926750732638, 7373.188949215475, 7374.410047196318], "unit": "score", "name": "mootools.html", "value": 5087.461471046894}, {"lowerIsBetter": false, "replicates": [325.77684286263906, 329.7774002548279, 335.60398729499184, 336.52885959656476, 338.56325340311014, 6528.804135875931, 6532.216134063913, 6573.408393244607, 6590.90113648295, 6606.405423511889, 5219.686818790875, 6410.423061924426, 6437.549371543993, 6483.254425741041, 6530.346965303467, 4611.30830375443, 4729.574338309551, 4762.452317983424, 4807.1587472192405, 4882.584980276681, 4719.4100737407825, 4790.113828941639, 4792.400949881265, 4823.421189457253, 4879.292502587123, 4795.153865761689, 4796.160671882424, 4809.927851082237, 4825.348577941985, 4827.975860120694, 4825.372701548794, 4827.951720482785, 4832.516748325174, 4834.444038935532, 4837.975810120962, 3325.6508066652896, 3930.253251882133, 4017.4978127734034, 4088.9795551022353, 4132.40080188374, 6169.0, 6199.628022318675, 6204.224471941007, 6205.5345849061505, 6227.816714824169, 5609.382967873531, 5617.859553511154, 5618.073017952033, 5619.67937534679, 5621.353544342412, 6914.481413893928, 6914.654267286615, 6919.5814857954, 6927.614477104599, 6931.792046238621, 4579.656525760548, 4594.517575654575, 4596.4254468191475, 4599.195140850371, 4602.240630296031, 6969.721211151598, 7245.746398876014, 7261.782146535559, 7323.0, 7327.633618319116, 4437.112577484516, 4508.346289787963, 4515.525869783691, 4523.95476045242, 4526.660500462479, 4598.8620341389815, 4604.286335617984, 4606.055758569552, 4607.0785842831565, 4609.976950115295, 4413.801378937956, 4778.808847646055, 5137.948620513747, 5456.645318054314, 5463.863403414867, 6905.516613836983, 6918.308169183041, 6926.722931082801, 6929.099217101744, 6934.687939042755, 1253.8746125387388, 1598.45652478158, 1600.8399160084132, 1603.959901002461, 1605.8474444927713, 874.3486102853287, 997.4214955325893, 1021.2902033086933, 1021.4535223655308, 1023.5701005577675, 6175.320714721377, 6256.593321434092, 6285.748570057147, 6378.489720822323, 6409.711562979677, 7160.176579693298, 7188.388986936065, 7196.0645116134565, 7249.528780629243, 7254.492185546961, 5610.49505544503, 6412.102305677209, 6456.289808121103, 6464.870702585922, 6478.2873883872735, 3751.5123034005405, 3782.3759079751535, 3784.1863999240295, 3786.6402691744242, 3788.962110378916, 7225.1329840419485, 7496.0, 7521.586312752851, 7559.622018899033, 7562.810929726801, 7363.042804435497, 7401.296876796696, 7423.0, 7431.554106753612, 7439.293267139613, 6357.93642063592, 6765.458763298924, 7268.27317268269, 7552.0, 7589.924100758922, 6535.215774107138, 6561.622059367395, 7221.783346499614, 7265.709371625076, 7266.781996540112, 6837.418819400406, 7057.258987806206, 7067.540609860343, 7071.646417678992, 7109.502334836512, 7470.215627359266, 7503.924960750541, 7525.924740752523, 7548.094228692592, 7563.205863384265, 4553.408056952575, 4611.16998940194, 4624.930626040545, 4625.861224163281, 4628.7454190018525, 7208.423326134001, 7239.384652304613, 7243.674034668347, 7243.710251589878, 7249.601271929883, 6726.39462448382, 6995.440364770908, 7002.75490357835, 7047.40097091753, 7056.659234745382, 6979.965100174467, 7002.474814388839, 7004.299570042955, 7007.089078419976, 7023.754168604074, 6834.897476537955, 6850.0, 6853.348931851466, 6854.554453960476, 6879.484038697017, 6986.231514533296, 6987.336203060701, 7015.263397343206, 7036.401905838061, 7037.542559733601, 6614.768483103068, 6621.238557565749, 6789.490788191004, 6803.285655006351, 6869.484788640772], "unit": "score", "name": "prototype.html", "value": 5047.617979800261}, {"lowerIsBetter": false, "replicates": [640.4588123036036, 705.4603228530174, 763.240575627251, 785.3363907498166, 789.6643926331308, 15380.307886145123, 15609.453669121584, 15621.531354059369, 15678.372865085412, 18032.0, 16699.0, 16771.496855094338, 16805.32778688851, 16824.579385515368, 16840.747388789146, 793.4921650143913, 804.4087595617245, 982.6855406269979, 1013.7110923386837, 1014.6043043213152, 986.0386123529573, 1006.4313662780505, 1006.9496525173712, 1007.415698894643, 1008.9596416143346, 1060.4114716332433, 1065.4353192807823, 1067.8184708599556, 1068.1935138970066, 1068.4978060311641, 842.1326034184768, 856.6402111113347, 1012.2357619996928, 1056.0179033498844, 1057.1542765787378, 765.9310662040388, 766.0730516075555, 766.6933226709305, 768.3353898877486, 768.8539177556303, 15756.527304180892, 15822.683546329008, 15822.920885395615, 15823.60440988973, 15838.76241856373, 12554.81167782484, 12708.809367859489, 12744.936275318563, 12998.92017277231, 13015.47938082485, 9136.58885350161, 10137.645182418653, 10435.478226088666, 10578.717490569768, 10987.230893837435, 3572.2676851245433, 3600.1899572596217, 3603.387424137903, 3692.723045771551, 3847.1151635123797, 86098.56950715269, 86964.8258793529, 86994.5650271751, 87927.0, 89040.55479722624, 9461.065880825106, 9595.328327017181, 9628.807423851484, 9772.364796288219, 9820.803583928424, 22066.227682031375, 22123.44691382696, 22198.88900555487, 22236.55526889453, 22495.550088998127, 7626.23737626244, 7642.273983971514, 7673.693052277847, 7726.652300646484, 7811.140774514799, 4203.012292111352, 4210.052738133895, 4221.915561688749, 4264.637505811978, 4468.262736648417, 3765.2657731742597, 3771.792551409644, 3804.543454785388, 3809.9238015240094, 3818.6181381861593, 703.0965209705504, 705.7424040225384, 708.6818517557339, 714.8320144765976, 719.8056524738291, 491.3784063160105, 511.53450360172064, 524.9133892907704, 555.8360283716313, 564.1678772561717, 8312.667493300321, 8330.291925186428, 8413.368997325226, 8520.062793092755, 8595.269402100766, 521.7000224870715, 591.4292707537247, 609.8444896551351, 620.385818040137, 627.2723640576909, 3878.9224215515533, 3917.3928041153667, 3917.7257591968287, 3977.2244412339314, 4014.136960553495, 102785.0, 103880.0, 105024.0, 105616.47191763992, 105869.94130058755, 84651.0, 85256.57371713225, 86171.5691421539, 86584.0, 88303.55848220718, 74899.0, 75288.11779705551, 75581.62209189028, 75971.0, 76840.0, 7734.071911370672, 7873.685052597832, 7968.123506414174, 8039.356851451753, 8069.31410830086, 49688.503114968385, 50198.74900625474, 51940.48059519356, 51970.740146299024, 52039.0, 67844.6607766958, 72826.90759638716, 75384.0, 76255.0, 77060.6146969284, 10057.748556286151, 10235.385876847413, 10327.173826094046, 10486.108680762221, 11033.896610338901, 10589.735256618646, 10715.57137714514, 10832.729181770519, 10973.561057557608, 11114.666560003212, 9317.673881414117, 9966.50167491608, 10274.691759247235, 10657.413842238751, 10798.244122911321, 10625.628103016667, 10641.0, 10736.946315268373, 10917.181211409335, 10970.670879873616, 9102.984413788363, 10215.438150901475, 10575.0, 10785.191110666889, 11308.717282068013, 8856.202941735275, 9020.86468702983, 9205.171534561921, 9347.719568412958, 9488.810223795623, 8979.0, 9023.503707296162, 9026.368154229142, 9065.81868362616, 9222.0], "unit": "score", "name": "yui.html", "value": 7093.189076495423}], "name": "dromaeo_css", "value": 7755.6055359338}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 111.0, 110.0, 111.0, 112.0, 121.0, 111.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [179.0, 151.0, 140.0, 153.0, 118.0, 135.0, 116.0, 150.0, 148.0, 116.0], "unit": "score", "name": "audio-beat-detection", "value": 140.6}, {"lowerIsBetter": true, "replicates": [184.0, 186.0, 184.0, 185.0, 185.0, 183.0, 184.0, 186.0, 185.0, 185.0], "unit": "score", "name": "audio-dft", "value": 184.7}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 76.0, 119.0, 55.0, 57.0, 60.0, 58.0, 120.0, 77.0], "unit": "score", "name": "audio-fft", "value": 76.7}, {"lowerIsBetter": true, "replicates": [91.0, 95.0, 128.0, 112.0, 97.0, 82.0, 121.0, 76.0, 77.0, 122.0], "unit": "score", "name": "audio-oscillator", "value": 100.1}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 88.0, 85.0, 87.0, 84.0, 87.0, 86.0, 87.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.1}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 93.0, 94.0, 93.0, 93.0, 94.0, 94.0, 92.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.1}, {"lowerIsBetter": true, "replicates": [125.0, 144.0, 84.0, 84.0, 86.0, 86.0, 88.0, 87.0, 86.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [54.0, 58.0, 58.0, 58.0, 58.0, 58.0, 57.0, 67.0, 55.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [61.0, 66.0, 102.0, 99.0, 108.0, 69.0, 68.0, 66.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 76.9}, {"lowerIsBetter": true, "replicates": [79.0, 101.0, 81.0, 81.0, 81.0, 80.0, 81.0, 77.0, 94.0, 111.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.6}, {"lowerIsBetter": true, "replicates": [121.0, 119.0, 128.0, 117.0, 116.0, 130.0, 124.0, 129.0, 131.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.2}, {"lowerIsBetter": true, "replicates": [134.0, 124.0, 133.0, 133.0, 133.0, 120.0, 130.0, 133.0, 132.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 130.4}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 67.0, 90.0, 99.0, 97.0, 80.0, 65.0, 66.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 76.0}], "name": "kraken", "value": 1438.9}]} 10:38:42 INFO - Return code: 0 10:38:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:38:42 INFO - # TBPL SUCCESS # 10:38:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:38:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:38:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:38:42 INFO - 2016-04-09 10:38:42.379 screenresolution[1979:15312] starting screenresolution argv=screenresolution get 10:38:42 INFO - 2016-04-09 10:38:42.381 screenresolution[1979:15312] Display 0: 1600x1200x32@60 10:38:42 INFO - 2016-04-09 10:38:42.387 screenresolution[1980:15315] starting screenresolution argv=screenresolution list 10:38:42 INFO - Available Modes on Display 0 10:38:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:38:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:38:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:38:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:38:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:38:42 INFO - Intel Iris: 10:38:42 INFO - Chipset Model: Intel Iris 10:38:42 INFO - Type: GPU 10:38:42 INFO - Bus: Built-In 10:38:42 INFO - VRAM (Dynamic, Max): 1536 MB 10:38:42 INFO - Vendor: Intel (0x8086) 10:38:42 INFO - Device ID: 0x0a2e 10:38:42 INFO - Revision ID: 0x0009 10:38:42 INFO - Displays: 10:38:42 INFO - Display: 10:38:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:38:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:38:42 INFO - Display Serial Number: 1600x1200 60 10:38:42 INFO - Main Display: Yes 10:38:42 INFO - Mirror: Off 10:38:42 INFO - Online: Yes 10:38:42 INFO - Rotation: Supported 10:38:42 INFO - Return code: 0 10:38:42 INFO - Running post-action listener: _resource_record_post_action 10:38:42 INFO - Running post-run listener: _resource_record_post_run 10:38:43 INFO - Total resource usage - Wall time: 1203s; CPU: 52.0%; Read bytes: 491520; Write bytes: 665792000; Read time: 5; Write time: 2472 10:38:43 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 360278528; Write bytes: 354686976; Read time: 28226; Write time: 651 10:38:43 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 491520; Write bytes: 299548160; Read time: 5; Write time: 1703 10:38:43 INFO - Running post-run listener: _upload_blobber_files 10:38:43 INFO - Blob upload gear active. 10:38:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:38:43 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 10:38:43 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'] 10:38:43 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 10:38:44 INFO - (blobuploader) - INFO - Open directory for files ... 10:38:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:38:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:38:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:38:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:38:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:38:44 INFO - (blobuploader) - INFO - Done attempting. 10:38:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:38:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:38:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:38:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:38:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:38:46 INFO - (blobuploader) - INFO - Done attempting. 10:38:46 INFO - (blobuploader) - INFO - Iteration through files over. 10:38:46 INFO - Return code: 0 10:38:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:38:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:38:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6369f5461b9516296c312a74e56e8e88efab34a939c16fe85936f60198e0ddd3fc1fcfde1b3aeb6c1c0f3d093fd07867941e591dfa1915077dbef2319c037bdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a982c57d128b87d97f6743a6ee562455814ef263dd7f1ee769996c231aeaac07371b55f508321502cefabd686a22666f440f9203e1b33b17977916fe246df78"} 10:38:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:38:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:38:46 INFO - Contents: 10:38:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6369f5461b9516296c312a74e56e8e88efab34a939c16fe85936f60198e0ddd3fc1fcfde1b3aeb6c1c0f3d093fd07867941e591dfa1915077dbef2319c037bdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a982c57d128b87d97f6743a6ee562455814ef263dd7f1ee769996c231aeaac07371b55f508321502cefabd686a22666f440f9203e1b33b17977916fe246df78"} 10:38:46 INFO - Running post-run listener: copy_logs_to_upload_dir 10:38:46 INFO - Copying logs to upload dir... 10:38:46 INFO - mkdir: /builds/slave/test/build/upload/logs 10:38:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1342.054717 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 22 secs) (at 2016-04-09 10:38:46.180066) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-09 10:38:46.187654) ========= 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.5l0662sdGo/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.SStxabx8AC/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6369f5461b9516296c312a74e56e8e88efab34a939c16fe85936f60198e0ddd3fc1fcfde1b3aeb6c1c0f3d093fd07867941e591dfa1915077dbef2319c037bdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a982c57d128b87d97f6743a6ee562455814ef263dd7f1ee769996c231aeaac07371b55f508321502cefabd686a22666f440f9203e1b33b17977916fe246df78"} build_url:https://queue.taskcluster.net/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011039 build_url: 'https://queue.taskcluster.net/v1/task/JhfFApxOSqmxlofz0kTOyw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6369f5461b9516296c312a74e56e8e88efab34a939c16fe85936f60198e0ddd3fc1fcfde1b3aeb6c1c0f3d093fd07867941e591dfa1915077dbef2319c037bdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a982c57d128b87d97f6743a6ee562455814ef263dd7f1ee769996c231aeaac07371b55f508321502cefabd686a22666f440f9203e1b33b17977916fe246df78"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-09 10:38:46.214731) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 10:38:46.215012) ========= 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.5l0662sdGo/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.SStxabx8AC/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.005144 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 10:38:46.267098) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-09 10:38:46.267383) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-09 10:38:46.267711) ========= ========= Total master_lag: 0.62 =========