builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0125 starttime: 1460411675.56 results: success (0) buildid: 20160411131746 builduid: e180de5667b44723a2bddd20b9a42428 revision: 1cff2bbb09ff3d87be20c32ceade91b70b40ad40 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 14:54:35.555347) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 14:54:35.555809) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 14:54:35.556125) ========= 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.zLZ09SFyFy/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.vg7hV07chT/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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.005587 basedir: '/builds/slave/test' ========= master_lag: 0.22 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 14:54:35.781231) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 14:54:35.781555) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 14:54:36.210812) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 14:54:36.211279) ========= 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.zLZ09SFyFy/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.vg7hV07chT/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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.006022 ========= master_lag: 0.26 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 14:54:36.473185) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 14:54:36.473498) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 14:54:36.473931) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 14:54:36.474236) ========= 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.zLZ09SFyFy/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.vg7hV07chT/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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-11 14:54:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 22.9M=0.001s 2016-04-11 14:54:37 (22.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.582985 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 14:54:37.184482) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 14:54:37.184913) ========= 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.zLZ09SFyFy/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.vg7hV07chT/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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.025307 ========= master_lag: 0.25 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 14:54:37.456894) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-11 14:54:37.457293) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1cff2bbb09ff3d87be20c32ceade91b70b40ad40 --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 1cff2bbb09ff3d87be20c32ceade91b70b40ad40 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zLZ09SFyFy/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.vg7hV07chT/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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-11 14:54:37,599 truncating revision to first 12 chars 2016-04-11 14:54:37,599 Setting DEBUG logging. 2016-04-11 14:54:37,599 attempt 1/10 2016-04-11 14:54:37,599 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1cff2bbb09ff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-11 14:54:40,475 unpacking tar archive at: mozilla-aurora-1cff2bbb09ff/testing/mozharness/ program finished with exit code 0 elapsedTime=3.785989 ========= master_lag: 0.15 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-11 14:54:41.391175) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 14:54:41.391534) ========= echo 1cff2bbb09ff3d87be20c32ceade91b70b40ad40 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1cff2bbb09ff3d87be20c32ceade91b70b40ad40'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zLZ09SFyFy/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.vg7hV07chT/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 1cff2bbb09ff3d87be20c32ceade91b70b40ad40 program finished with exit code 0 elapsedTime=0.006103 script_repo_revision: '1cff2bbb09ff3d87be20c32ceade91b70b40ad40' ========= master_lag: 0.45 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 14:54:41.852583) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 14:54:41.852916) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 14:54:42.410278) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-04-11 14:54:42.410687) ========= /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.zLZ09SFyFy/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.vg7hV07chT/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 14:54:42 INFO - MultiFileLogger online at 20160411 14:54:42 in /builds/slave/test 14:54:42 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 14:54:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:54:42 INFO - {'append_to_log': False, 14:54:42 INFO - 'base_work_dir': '/builds/slave/test', 14:54:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:54:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:54:42 INFO - 'branch': 'Mozilla-Aurora', 14:54:42 INFO - 'buildbot_json_path': 'buildprops.json', 14:54:42 INFO - 'config_files': ('talos/mac_config.py',), 14:54:42 INFO - 'default_actions': ('clobber', 14:54:42 INFO - 'read-buildbot-config', 14:54:42 INFO - 'download-and-extract', 14:54:42 INFO - 'populate-webroot', 14:54:42 INFO - 'create-virtualenv', 14:54:42 INFO - 'install', 14:54:42 INFO - 'run-tests'), 14:54:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:54:42 INFO - 'download_minidump_stackwalk': True, 14:54:42 INFO - 'download_symbols': 'ondemand', 14:54:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:54:42 INFO - 'tooltool.py': '/tools/tooltool.py', 14:54:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:54:42 INFO - '/tools/misc-python/virtualenv.py')}, 14:54:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:54:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:54:42 INFO - 'installer_path': 'installer.exe', 14:54:42 INFO - 'log_level': 'info', 14:54:42 INFO - 'log_name': 'talos', 14:54:42 INFO - 'log_to_console': True, 14:54:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:54:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:54:42 INFO - 'opt_config_files': (), 14:54:42 INFO - 'pip_index': False, 14:54:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:54:42 INFO - 'cmd': ('bash', 14:54:42 INFO - '-c', 14:54:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:54:42 INFO - 'enabled': True, 14:54:42 INFO - 'halt_on_failure': False, 14:54:42 INFO - 'name': 'check_screen_resolution'},), 14:54:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:54:42 INFO - 'cmd': ('bash', 14:54:42 INFO - '-c', 14:54:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:54:42 INFO - 'enabled': True, 14:54:42 INFO - 'halt_on_failure': False, 14:54:42 INFO - 'name': 'check_screen_resolution'},), 14:54:42 INFO - 'run_cmd_checks_enabled': True, 14:54:42 INFO - 'sps_profile': False, 14:54:42 INFO - 'sps_profile_interval': 0, 14:54:42 INFO - 'suite': 'dromaeojs', 14:54:42 INFO - 'system_bits': '32', 14:54:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:54:42 INFO - 'title': 't-yosemite-r7-0125', 14:54:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:54:42 INFO - 'use_talos_json': True, 14:54:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:54:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:54:42 INFO - 'work_dir': 'build'} 14:54:42 INFO - ##### 14:54:42 INFO - ##### Running clobber step. 14:54:42 INFO - ##### 14:54:42 INFO - Running pre-action listener: _resource_record_pre_action 14:54:42 INFO - Running main action method: clobber 14:54:42 INFO - rmtree: /builds/slave/test/build 14:54:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:54:44 INFO - Running post-action listener: _resource_record_post_action 14:54:44 INFO - ##### 14:54:44 INFO - ##### Running read-buildbot-config step. 14:54:44 INFO - ##### 14:54:44 INFO - Running pre-action listener: _resource_record_pre_action 14:54:44 INFO - Running main action method: read_buildbot_config 14:54:44 INFO - Using buildbot properties: 14:54:44 INFO - { 14:54:44 INFO - "project": "", 14:54:44 INFO - "product": "firefox", 14:54:44 INFO - "script_repo_revision": "production", 14:54:44 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 14:54:44 INFO - "repository": "", 14:54:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 14:54:44 INFO - "buildid": "20160411131746", 14:54:44 INFO - "pgo_build": "False", 14:54:44 INFO - "basedir": "/builds/slave/test", 14:54:44 INFO - "buildnumber": 272, 14:54:44 INFO - "slavename": "t-yosemite-r7-0125", 14:54:44 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:54:44 INFO - "platform": "yosemite_r7", 14:54:44 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 14:54:44 INFO - "branch": "mozilla-aurora", 14:54:44 INFO - "repo_path": "releases/mozilla-aurora", 14:54:44 INFO - "revision": "1cff2bbb09ff3d87be20c32ceade91b70b40ad40", 14:54:44 INFO - "stage_platform": "macosx64", 14:54:44 INFO - "builduid": "e180de5667b44723a2bddd20b9a42428", 14:54:44 INFO - "slavebuilddir": "test" 14:54:44 INFO - } 14:54:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/GYqG9k7pSTClgXnwTOANog/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 14:54:44 INFO - Running post-action listener: _resource_record_post_action 14:54:44 INFO - ##### 14:54:44 INFO - ##### Running download-and-extract step. 14:54:44 INFO - ##### 14:54:44 INFO - Running pre-action listener: _resource_record_pre_action 14:54:44 INFO - Running main action method: download_and_extract 14:54:44 INFO - mkdir: /builds/slave/test/build/tests 14:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:44 INFO - https://queue.taskcluster.net/v1/task/GYqG9k7pSTClgXnwTOANog/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:54:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYqG9k7pSTClgXnwTOANog/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 14:54:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYqG9k7pSTClgXnwTOANog/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 14:54:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYqG9k7pSTClgXnwTOANog/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 14:54:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYqG9k7pSTClgXnwTOANog/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 14:54:46 INFO - Downloaded 1277 bytes. 14:54:46 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 14:54:46 INFO - Using the following test package requirements: 14:54:46 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 14:54:46 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 14:54:46 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 14:54:46 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 14:54:46 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 14:54:46 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 14:54:46 INFO - u'jsshell-mac.zip'], 14:54:46 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 14:54:46 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 14:54:46 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 14:54:46 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 14:54:46 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 14:54:46 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 14:54:46 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 14:54:46 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 14:54:46 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 14:54:46 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 14:54:46 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 14:54:46 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 14:54:46 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 14:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:46 INFO - https://queue.taskcluster.net/v1/task/GYqG9k7pSTClgXnwTOANog/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:54:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYqG9k7pSTClgXnwTOANog/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 14:54:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYqG9k7pSTClgXnwTOANog/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 14:54:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYqG9k7pSTClgXnwTOANog/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 14:54:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYqG9k7pSTClgXnwTOANog/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 14:54:48 INFO - Downloaded 17908579 bytes. 14:54:48 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'] 14:54:48 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 14:54:51 INFO - Return code: 0 14:54:51 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 14:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:51 INFO - https://queue.taskcluster.net/v1/task/GYqG9k7pSTClgXnwTOANog/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:54:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYqG9k7pSTClgXnwTOANog/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 14:54:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYqG9k7pSTClgXnwTOANog/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 14:54:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYqG9k7pSTClgXnwTOANog/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 14:54:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYqG9k7pSTClgXnwTOANog/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 14:54:53 INFO - Downloaded 17908579 bytes. 14:54:53 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'] 14:54:53 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 14:54:56 INFO - Return code: 0 14:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:56 INFO - https://queue.taskcluster.net/v1/task/GYqG9k7pSTClgXnwTOANog/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:54:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYqG9k7pSTClgXnwTOANog/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 14:54:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYqG9k7pSTClgXnwTOANog/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 14:54:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYqG9k7pSTClgXnwTOANog/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 14:54:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYqG9k7pSTClgXnwTOANog/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 14:55:04 INFO - Downloaded 10845168 bytes. 14:55:04 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'] 14:55:04 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 14:55:04 INFO - Return code: 0 14:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:04 INFO - https://queue.taskcluster.net/v1/task/GYqG9k7pSTClgXnwTOANog/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 14:55:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYqG9k7pSTClgXnwTOANog/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 14:55:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYqG9k7pSTClgXnwTOANog/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 14:55:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYqG9k7pSTClgXnwTOANog/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 14:55:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYqG9k7pSTClgXnwTOANog/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 14:55:08 INFO - Downloaded 115192324 bytes. 14:55:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GYqG9k7pSTClgXnwTOANog/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 14:55:08 INFO - mkdir: /builds/slave/test/properties 14:55:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:55:08 INFO - Writing to file /builds/slave/test/properties/build_url 14:55:08 INFO - Contents: 14:55:08 INFO - build_url:https://queue.taskcluster.net/v1/task/GYqG9k7pSTClgXnwTOANog/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 14:55:10 INFO - Running post-action listener: _resource_record_post_action 14:55:10 INFO - Running post-action listener: set_extra_try_arguments 14:55:10 INFO - ##### 14:55:10 INFO - ##### Running populate-webroot step. 14:55:10 INFO - ##### 14:55:10 INFO - Running pre-action listener: _resource_record_pre_action 14:55:10 INFO - Running main action method: populate_webroot 14:55:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:55:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:55:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:55:10 INFO - '--tppagecycles', 14:55:10 INFO - '7'], 14:55:10 INFO - 'tests': ['tsvgm']}}, 14:55:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:55:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:55:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:55:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:55:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:55:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:55:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:55:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:10 INFO - 'talos_options': ['--e10s'], 14:55:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:55:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:10 INFO - 'tests': ['damp', 'tps']}, 14:55:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:10 INFO - 'talos_options': ['--e10s'], 14:55:10 INFO - 'tests': ['damp', 'tps']}, 14:55:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:55:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:55:10 INFO - 'other': {'tests': ['a11yr', 14:55:10 INFO - 'ts_paint', 14:55:10 INFO - 'tpaint', 14:55:10 INFO - 'sessionrestore', 14:55:10 INFO - 'sessionrestore_no_auto_restore', 14:55:10 INFO - 'tabpaint']}, 14:55:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:55:10 INFO - 'tests': ['a11yr', 14:55:10 INFO - 'ts_paint', 14:55:10 INFO - 'tpaint', 14:55:10 INFO - 'sessionrestore', 14:55:10 INFO - 'sessionrestore_no_auto_restore', 14:55:10 INFO - 'tabpaint']}, 14:55:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:55:10 INFO - 'tests': ['a11yr', 14:55:10 INFO - 'ts_paint', 14:55:10 INFO - 'tpaint', 14:55:10 INFO - 'sessionrestore', 14:55:10 INFO - 'sessionrestore_no_auto_restore', 14:55:10 INFO - 'tabpaint']}, 14:55:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:55:10 INFO - 'tests': ['a11yr', 14:55:10 INFO - 'ts_paint', 14:55:10 INFO - 'tpaint', 14:55:10 INFO - 'sessionrestore', 14:55:10 INFO - 'sessionrestore_no_auto_restore', 14:55:10 INFO - 'tabpaint']}, 14:55:10 INFO - 'other_l64': {'tests': ['a11yr', 14:55:10 INFO - 'ts_paint', 14:55:10 INFO - 'tpaint', 14:55:10 INFO - 'sessionrestore', 14:55:10 INFO - 'sessionrestore_no_auto_restore', 14:55:10 INFO - 'tabpaint']}, 14:55:10 INFO - 'other_nol64': {'tests': ['a11yr', 14:55:10 INFO - 'ts_paint', 14:55:10 INFO - 'tpaint', 14:55:10 INFO - 'sessionrestore', 14:55:10 INFO - 'sessionrestore_no_auto_restore', 14:55:10 INFO - 'tabpaint']}, 14:55:10 INFO - 'svgr': {'tests': ['tsvgx', 14:55:10 INFO - 'tsvgr_opacity', 14:55:10 INFO - 'tart', 14:55:10 INFO - 'tscrollx', 14:55:10 INFO - 'cart']}, 14:55:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:55:10 INFO - 'tests': ['tsvgx', 14:55:10 INFO - 'tsvgr_opacity', 14:55:10 INFO - 'tart', 14:55:10 INFO - 'tscrollx', 14:55:10 INFO - 'cart']}, 14:55:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:10 INFO - 'tests': ['tp5o']}, 14:55:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:10 INFO - 'talos_options': ['--e10s'], 14:55:10 INFO - 'tests': ['tp5o']}, 14:55:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:10 INFO - 'talos_options': ['--xperf_path', 14:55:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:55:10 INFO - 'tests': ['tp5n']}, 14:55:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:10 INFO - 'talos_options': ['--e10s', 14:55:10 INFO - '--xperf_path', 14:55:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:55:10 INFO - 'tests': ['tp5n']}}, 14:55:10 INFO - 'talos.zip': {'path': '', 14:55:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:55:10 INFO - Running post-action listener: _resource_record_post_action 14:55:10 INFO - ##### 14:55:10 INFO - ##### Running create-virtualenv step. 14:55:10 INFO - ##### 14:55:10 INFO - Running pre-action listener: _resource_record_pre_action 14:55:10 INFO - Running main action method: create_virtualenv 14:55:10 INFO - Creating virtualenv /builds/slave/test/build/venv 14:55:10 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 14:55:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:55:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:55:10 INFO - Using real prefix '/tools/python27' 14:55:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:55:11 INFO - Installing distribute.............................................................................................................................................................................................done. 14:55:14 INFO - Installing pip.................done. 14:55:14 INFO - Return code: 0 14:55:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:55:14 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')]} 14:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:14 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')]} 14:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:14 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 0x1040d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fd3479120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f78d30>, '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 0x103ddcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f6fb20>, '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.zLZ09SFyFy/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.vg7hV07chT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 14:55:14 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 14:55:14 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 14:55:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zLZ09SFyFy/Render', 14:55:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:55:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:55:14 INFO - 'HOME': '/Users/cltbld', 14:55:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:55:14 INFO - 'LOGNAME': 'cltbld', 14:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:14 INFO - 'MOZ_NO_REMOTE': '1', 14:55:14 INFO - 'NO_EM_RESTART': '1', 14:55:14 INFO - 'PAGER': '/bin/cat', 14:55:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:14 INFO - 'PWD': '/builds/slave/test', 14:55:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:55:14 INFO - 'SHELL': '/bin/bash', 14:55:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vg7hV07chT/Listeners', 14:55:14 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 14:55:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:55:14 INFO - 'USER': 'cltbld', 14:55:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:55:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:14 INFO - 'XPC_FLAGS': '0x0', 14:55:14 INFO - 'XPC_SERVICE_NAME': '0', 14:55:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:14 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 14:55:14 INFO - Cleaning up... 14:55:14 INFO - Return code: 0 14:55:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:55:14 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')]} 14:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:14 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')]} 14:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:14 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 0x1040d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fd3479120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f78d30>, '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 0x103ddcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f6fb20>, '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.zLZ09SFyFy/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.vg7hV07chT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 14:55:14 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 14:55:14 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 14:55:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zLZ09SFyFy/Render', 14:55:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:55:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:55:14 INFO - 'HOME': '/Users/cltbld', 14:55:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:55:14 INFO - 'LOGNAME': 'cltbld', 14:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:14 INFO - 'MOZ_NO_REMOTE': '1', 14:55:14 INFO - 'NO_EM_RESTART': '1', 14:55:14 INFO - 'PAGER': '/bin/cat', 14:55:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:14 INFO - 'PWD': '/builds/slave/test', 14:55:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:55:14 INFO - 'SHELL': '/bin/bash', 14:55:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vg7hV07chT/Listeners', 14:55:14 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 14:55:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:55:14 INFO - 'USER': 'cltbld', 14:55:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:55:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:14 INFO - 'XPC_FLAGS': '0x0', 14:55:14 INFO - 'XPC_SERVICE_NAME': '0', 14:55:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:14 INFO - Downloading/unpacking psutil>=0.7.1 14:55:14 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 14:55:14 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 14:55:14 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 14:55:14 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 14:55:14 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 14:55:14 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 14:55:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:55:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:55:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:55:19 INFO - Installing collected packages: psutil 14:55:19 INFO - Running setup.py install for psutil 14:55:19 INFO - building 'psutil._psutil_osx' extension 14:55:19 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 14:55:20 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 14:55:20 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 14:55:20 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 14:55:20 INFO - building 'psutil._psutil_posix' extension 14:55:20 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 14:55:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:55:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:55:20 INFO - ^ 14:55:20 INFO - 1 warning generated. 14:55:20 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 14:55:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:55:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:55:20 INFO - Successfully installed psutil 14:55:20 INFO - Cleaning up... 14:55:20 INFO - Return code: 0 14:55:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:55:20 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')]} 14:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:20 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')]} 14:55:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:20 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 0x1040d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fd3479120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f78d30>, '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 0x103ddcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f6fb20>, '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.zLZ09SFyFy/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.vg7hV07chT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 14:55:20 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 14:55:20 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 14:55:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zLZ09SFyFy/Render', 14:55:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:55:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:55:20 INFO - 'HOME': '/Users/cltbld', 14:55:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:55:20 INFO - 'LOGNAME': 'cltbld', 14:55:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:20 INFO - 'MOZ_NO_REMOTE': '1', 14:55:20 INFO - 'NO_EM_RESTART': '1', 14:55:20 INFO - 'PAGER': '/bin/cat', 14:55:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:55:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:20 INFO - 'PWD': '/builds/slave/test', 14:55:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:55:20 INFO - 'SHELL': '/bin/bash', 14:55:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vg7hV07chT/Listeners', 14:55:20 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 14:55:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:55:20 INFO - 'USER': 'cltbld', 14:55:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:55:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:55:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:20 INFO - 'XPC_FLAGS': '0x0', 14:55:20 INFO - 'XPC_SERVICE_NAME': '0', 14:55:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:55:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:55:21 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 14:55:21 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 14:55:21 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 14:55:21 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 14:55:21 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 14:55:21 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 14:55:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:55:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:55:23 INFO - Installing collected packages: mozsystemmonitor 14:55:23 INFO - Running setup.py install for mozsystemmonitor 14:55:23 INFO - Successfully installed mozsystemmonitor 14:55:23 INFO - Cleaning up... 14:55:23 INFO - Return code: 0 14:55:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:23 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 0x1040d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fd3479120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f78d30>, '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 0x103ddcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f6fb20>, '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.zLZ09SFyFy/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.vg7hV07chT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 14:55:23 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 14:55:23 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 14:55:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zLZ09SFyFy/Render', 14:55:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:55:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:55:23 INFO - 'HOME': '/Users/cltbld', 14:55:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:55:23 INFO - 'LOGNAME': 'cltbld', 14:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:23 INFO - 'MOZ_NO_REMOTE': '1', 14:55:23 INFO - 'NO_EM_RESTART': '1', 14:55:23 INFO - 'PAGER': '/bin/cat', 14:55:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:55:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:23 INFO - 'PWD': '/builds/slave/test', 14:55:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:55:23 INFO - 'SHELL': '/bin/bash', 14:55:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vg7hV07chT/Listeners', 14:55:23 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 14:55:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:55:23 INFO - 'USER': 'cltbld', 14:55:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:55:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:23 INFO - 'XPC_FLAGS': '0x0', 14:55:23 INFO - 'XPC_SERVICE_NAME': '0', 14:55:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:55:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:24 INFO - Downloading/unpacking blobuploader==1.2.4 14:55:24 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 14:55:24 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 14:55:24 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 14:55:24 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 14:55:24 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 14:55:24 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 14:55:29 INFO - Downloading blobuploader-1.2.4.tar.gz 14:55:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:55:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:55:29 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 14:55:29 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 14:55:29 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 14:55:29 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 14:55:29 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 14:55:29 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 14:55:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:55:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:55: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 14:55: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 14:55: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 14:55: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 14:55: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 14:55: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 14:55:31 INFO - Downloading docopt-0.6.1.tar.gz 14:55:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:55:31 INFO - Installing collected packages: blobuploader, requests, docopt 14:55:31 INFO - Running setup.py install for blobuploader 14:55:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:55:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:55:31 INFO - Running setup.py install for requests 14:55:31 INFO - Running setup.py install for docopt 14:55:32 INFO - Successfully installed blobuploader requests docopt 14:55:32 INFO - Cleaning up... 14:55:32 INFO - Return code: 0 14:55:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:55:32 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')]} 14:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:32 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')]} 14:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:32 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 0x1040d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fd3479120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f78d30>, '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 0x103ddcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f6fb20>, '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.zLZ09SFyFy/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.vg7hV07chT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 14:55:32 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 14:55:32 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 14:55:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zLZ09SFyFy/Render', 14:55:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:55:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:55:32 INFO - 'HOME': '/Users/cltbld', 14:55:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:55:32 INFO - 'LOGNAME': 'cltbld', 14:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:32 INFO - 'MOZ_NO_REMOTE': '1', 14:55:32 INFO - 'NO_EM_RESTART': '1', 14:55:32 INFO - 'PAGER': '/bin/cat', 14:55:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:32 INFO - 'PWD': '/builds/slave/test', 14:55:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:55:32 INFO - 'SHELL': '/bin/bash', 14:55:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vg7hV07chT/Listeners', 14:55:32 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 14:55:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:55:32 INFO - 'USER': 'cltbld', 14:55:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:55:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:32 INFO - 'XPC_FLAGS': '0x0', 14:55:32 INFO - 'XPC_SERVICE_NAME': '0', 14:55:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:55:32 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-rQTXJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:55:32 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-ofQn2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:55:33 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-DCP8An-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:55:33 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-3SSwFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:55:33 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-SuoJ3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:55:33 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-3IyeH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:55:33 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-UJhL_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:55:33 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-kITtPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:55:33 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-2DmOQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:55:33 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-o2HCP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:55:33 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-iOoSMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:55:33 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-nomvHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:55:34 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-DZQGtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:55:34 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-tq70Hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:55:34 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-fJXZcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:55:34 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-1k_UUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:55:34 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-2TdViF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:55:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:55:34 INFO - Running setup.py install for manifestparser 14:55:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:55:34 INFO - Running setup.py install for mozcrash 14:55:34 INFO - Running setup.py install for mozdebug 14:55:35 INFO - Running setup.py install for mozdevice 14:55:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:55:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:55:35 INFO - Running setup.py install for mozfile 14:55:35 INFO - Running setup.py install for mozhttpd 14:55:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:55:35 INFO - Running setup.py install for mozinfo 14:55:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:55:35 INFO - Running setup.py install for mozInstall 14:55:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:55:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:55:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:55:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:55:35 INFO - Running setup.py install for mozleak 14:55:35 INFO - Running setup.py install for mozlog 14:55:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:55:36 INFO - Running setup.py install for moznetwork 14:55:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:55:36 INFO - Running setup.py install for mozprocess 14:55:36 INFO - Running setup.py install for mozprofile 14:55:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:55:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:55:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:55:36 INFO - Running setup.py install for mozrunner 14:55:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:55:36 INFO - Running setup.py install for mozscreenshot 14:55:36 INFO - Running setup.py install for moztest 14:55:37 INFO - Running setup.py install for mozversion 14:55:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:55:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:55:37 INFO - Cleaning up... 14:55:37 INFO - Return code: 0 14:55:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:37 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 0x1040d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fd3479120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f78d30>, '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 0x103ddcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f6fb20>, '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.zLZ09SFyFy/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.vg7hV07chT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 14:55:37 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 14:55:37 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 14:55:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zLZ09SFyFy/Render', 14:55:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:55:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:55:37 INFO - 'HOME': '/Users/cltbld', 14:55:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:55:37 INFO - 'LOGNAME': 'cltbld', 14:55:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:37 INFO - 'MOZ_NO_REMOTE': '1', 14:55:37 INFO - 'NO_EM_RESTART': '1', 14:55:37 INFO - 'PAGER': '/bin/cat', 14:55:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:55:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:37 INFO - 'PWD': '/builds/slave/test', 14:55:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:55:37 INFO - 'SHELL': '/bin/bash', 14:55:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vg7hV07chT/Listeners', 14:55:37 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 14:55:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:55:37 INFO - 'USER': 'cltbld', 14:55:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:55:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:55:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:37 INFO - 'XPC_FLAGS': '0x0', 14:55:37 INFO - 'XPC_SERVICE_NAME': '0', 14:55:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:55:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:55:37 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-GusogR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:55:37 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)) 14:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:55:37 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-anyEsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:55:37 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)) 14:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:55:37 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-eEVAzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:55:37 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)) 14:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:55:37 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-6M02PU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:55:37 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)) 14:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:55:37 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-_8N3bI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:55:37 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)) 14:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:55:37 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-vO24LZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:55:38 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)) 14:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:55:38 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-8za5wO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:55:38 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)) 14:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:55:38 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-zgvtAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:55:38 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)) 14:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:55:38 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-TGNjhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:55:38 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)) 14:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:55:38 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-8hcbQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:55:38 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)) 14:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:55:38 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-NxHFgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:55:38 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)) 14:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:55:38 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-lqaFN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:55:38 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)) 14:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:55:38 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-qzKNxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:55:38 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)) 14:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:55:38 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-dkiaUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:55:38 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)) 14:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:55:38 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-vai_2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:55:39 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)) 14:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:55:39 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-NyB1MY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:55:39 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)) 14:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:55:39 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-EfEms8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:55:39 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)) 14:55:39 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)) 14:55:39 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)) 14:55:39 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)) 14:55:39 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)) 14:55:39 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)) 14:55:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:43 INFO - Downloading blessings-1.6.tar.gz 14:55:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:55:43 INFO - Installing collected packages: blessings 14:55:43 INFO - Running setup.py install for blessings 14:55:43 INFO - Successfully installed blessings 14:55:43 INFO - Cleaning up... 14:55:43 INFO - Return code: 0 14:55:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:55:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:55:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:55:44 INFO - Reading from file tmpfile_stdout 14:55:44 INFO - Current package versions: 14:55:44 INFO - blessings == 1.6 14:55:44 INFO - blobuploader == 1.2.4 14:55:44 INFO - docopt == 0.6.1 14:55:44 INFO - manifestparser == 1.1 14:55:44 INFO - mozInstall == 1.12 14:55:44 INFO - mozcrash == 0.17 14:55:44 INFO - mozdebug == 0.1 14:55:44 INFO - mozdevice == 0.48 14:55:44 INFO - mozfile == 1.2 14:55:44 INFO - mozhttpd == 0.7 14:55:44 INFO - mozinfo == 0.9 14:55:44 INFO - mozleak == 0.1 14:55:44 INFO - mozlog == 3.1 14:55:44 INFO - moznetwork == 0.27 14:55:44 INFO - mozprocess == 0.22 14:55:44 INFO - mozprofile == 0.28 14:55:44 INFO - mozrunner == 6.11 14:55:44 INFO - mozscreenshot == 0.1 14:55:44 INFO - mozsystemmonitor == 0.0 14:55:44 INFO - moztest == 0.7 14:55:44 INFO - mozversion == 1.4 14:55:44 INFO - psutil == 3.1.1 14:55:44 INFO - requests == 1.2.3 14:55:44 INFO - wsgiref == 0.1.2 14:55:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:44 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 0x1040d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fd3479120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f78d30>, '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 0x103ddcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f6fb20>, '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.zLZ09SFyFy/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.vg7hV07chT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 14:55:44 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 14:55:44 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 14:55:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zLZ09SFyFy/Render', 14:55:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:55:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:55:44 INFO - 'HOME': '/Users/cltbld', 14:55:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:55:44 INFO - 'LOGNAME': 'cltbld', 14:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:44 INFO - 'MOZ_NO_REMOTE': '1', 14:55:44 INFO - 'NO_EM_RESTART': '1', 14:55:44 INFO - 'PAGER': '/bin/cat', 14:55:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:44 INFO - 'PWD': '/builds/slave/test', 14:55:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:55:44 INFO - 'SHELL': '/bin/bash', 14:55:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vg7hV07chT/Listeners', 14:55:44 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 14:55:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:55:44 INFO - 'USER': 'cltbld', 14:55:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:55:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:44 INFO - 'XPC_FLAGS': '0x0', 14:55:44 INFO - 'XPC_SERVICE_NAME': '0', 14:55:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:55:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:44 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)) 14:55:44 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)) 14:55:44 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)) 14:55:44 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)) 14:55:44 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)) 14:55:44 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)) 14:55:44 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)) 14:55:44 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)) 14:55:44 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)) 14:55:44 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)) 14:55:44 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)) 14:55:44 INFO - Cleaning up... 14:55:44 INFO - Return code: 0 14:55:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:44 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 0x1040d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fd3479120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f78d30>, '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 0x103ddcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f6fb20>, '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.zLZ09SFyFy/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.vg7hV07chT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 14:55:44 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 14:55:44 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 14:55:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zLZ09SFyFy/Render', 14:55:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:55:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:55:44 INFO - 'HOME': '/Users/cltbld', 14:55:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:55:44 INFO - 'LOGNAME': 'cltbld', 14:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:44 INFO - 'MOZ_NO_REMOTE': '1', 14:55:44 INFO - 'NO_EM_RESTART': '1', 14:55:44 INFO - 'PAGER': '/bin/cat', 14:55:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:44 INFO - 'PWD': '/builds/slave/test', 14:55:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:55:44 INFO - 'SHELL': '/bin/bash', 14:55:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vg7hV07chT/Listeners', 14:55:44 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 14:55:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:55:44 INFO - 'USER': 'cltbld', 14:55:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:55:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:44 INFO - 'XPC_FLAGS': '0x0', 14:55:44 INFO - 'XPC_SERVICE_NAME': '0', 14:55:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:55:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:44 INFO - Downloading/unpacking jsonschema 14:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:55:48 INFO - Downloading/unpacking functools32 (from jsonschema) 14:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:49 INFO - Downloading functools32-3.2.3-2.tar.gz 14:55:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:55:49 INFO - warning: no files found matching '*.txt' 14:55:49 INFO - no previously-included directories found matching 'build' 14:55:49 INFO - no previously-included directories found matching 'dist' 14:55:49 INFO - no previously-included directories found matching '.git*' 14:55:49 INFO - Installing collected packages: jsonschema, functools32 14:55:49 INFO - Running setup.py install for functools32 14:55:49 INFO - warning: no files found matching '*.txt' 14:55:49 INFO - no previously-included directories found matching 'build' 14:55:49 INFO - no previously-included directories found matching 'dist' 14:55:49 INFO - no previously-included directories found matching '.git*' 14:55:49 INFO - Successfully installed jsonschema functools32 14:55:49 INFO - Cleaning up... 14:55:49 INFO - Return code: 0 14:55:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1040d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fd3479120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f78d30>, '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 0x103ddcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f6fb20>, '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.zLZ09SFyFy/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.vg7hV07chT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 14:55:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:55:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:55:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zLZ09SFyFy/Render', 14:55:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:55:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:55:49 INFO - 'HOME': '/Users/cltbld', 14:55:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:55:49 INFO - 'LOGNAME': 'cltbld', 14:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:49 INFO - 'MOZ_NO_REMOTE': '1', 14:55:49 INFO - 'NO_EM_RESTART': '1', 14:55:49 INFO - 'PAGER': '/bin/cat', 14:55:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:49 INFO - 'PWD': '/builds/slave/test', 14:55:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:55:49 INFO - 'SHELL': '/bin/bash', 14:55:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vg7hV07chT/Listeners', 14:55:49 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 14:55:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:55:49 INFO - 'USER': 'cltbld', 14:55:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:55:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:49 INFO - 'XPC_FLAGS': '0x0', 14:55:49 INFO - 'XPC_SERVICE_NAME': '0', 14:55:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:50 INFO - Downloading/unpacking flake8 14:55:50 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 14:55:50 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 14:55:50 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 14:55:50 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 14:55:50 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 14:55:50 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 14:55:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:55:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:55:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:55:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:55:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:55:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:55:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:55:55 INFO - no previously-included directories found matching 'docs/_build' 14:55:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:55:55 INFO - Running setup.py install for pep8 14:55:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:55:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:55:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:55:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:55:56 INFO - no previously-included directories found matching 'docs/_build' 14:55:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:55:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:55:56 INFO - Cleaning up... 14:55:56 INFO - Return code: 0 14:55:56 INFO - Running post-action listener: _resource_record_post_action 14:55:56 INFO - Running post-action listener: _start_resource_monitoring 14:55:56 INFO - Starting resource monitoring. 14:55:56 INFO - ##### 14:55:56 INFO - ##### Running install step. 14:55:56 INFO - ##### 14:55:56 INFO - Running pre-action listener: _resource_record_pre_action 14:55:56 INFO - Running main action method: install 14:55:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:55:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:55:56 INFO - Reading from file tmpfile_stdout 14:55:56 INFO - Detecting whether we're running mozinstall >=1.0... 14:55:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:55:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:55:56 INFO - Reading from file tmpfile_stdout 14:55:56 INFO - Output received: 14:55:56 INFO - Usage: mozinstall [options] installer 14:55:56 INFO - Options: 14:55:56 INFO - -h, --help show this help message and exit 14:55:56 INFO - -d DEST, --destination=DEST 14:55:56 INFO - Directory to install application into. [default: 14:55:56 INFO - "/builds/slave/test"] 14:55:56 INFO - --app=APP Application being installed. [default: firefox] 14:55:56 INFO - mkdir: /builds/slave/test/build/application 14:55:56 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'] 14:55:56 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 14:56:28 INFO - Reading from file tmpfile_stdout 14:56:28 INFO - Output received: 14:56:28 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 14:56:28 INFO - Running post-action listener: _resource_record_post_action 14:56:28 INFO - ##### 14:56:28 INFO - ##### Running run-tests step. 14:56:28 INFO - ##### 14:56:28 INFO - Running pre-action listener: _resource_record_pre_action 14:56:28 INFO - Running main action method: run_tests 14:56:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:56:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:56:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:56:28 INFO - 2016-04-11 14:56:28.706 screenresolution[1642:7559] starting screenresolution argv=screenresolution get 14:56:28 INFO - 2016-04-11 14:56:28.709 screenresolution[1642:7559] Display 0: 1600x1200x32@60 14:56:28 INFO - 2016-04-11 14:56:28.714 screenresolution[1643:7561] starting screenresolution argv=screenresolution list 14:56:28 INFO - Available Modes on Display 0 14:56:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:56:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:56:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:56:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:56:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:56:28 INFO - Intel Iris: 14:56:28 INFO - Chipset Model: Intel Iris 14:56:28 INFO - Type: GPU 14:56:28 INFO - Bus: Built-In 14:56:28 INFO - VRAM (Dynamic, Max): 1536 MB 14:56:28 INFO - Vendor: Intel (0x8086) 14:56:28 INFO - Device ID: 0x0a2e 14:56:28 INFO - Revision ID: 0x0009 14:56:28 INFO - Displays: 14:56:28 INFO - Display: 14:56:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:56:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:56:28 INFO - Display Serial Number: 1600x1200 60 14:56:28 INFO - Main Display: Yes 14:56:28 INFO - Mirror: Off 14:56:28 INFO - Online: Yes 14:56:28 INFO - Rotation: Supported 14:56:28 INFO - Return code: 0 14:56:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:56:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:56:28 INFO - Python 2.7.3 14:56:28 INFO - Return code: 0 14:56:28 INFO - grabbing minidump binary from tooltool 14:56:28 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')]} 14:56:28 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 0x103f78d30>, '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 0x103ddcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f6fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:56:28 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 14:56:28 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 14:56:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:56:29 INFO - Return code: 0 14:56:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:56:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:56:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:56:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:56:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:56:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:56:30 INFO - Return code: 0 14:56:30 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/GYqG9k7pSTClgXnwTOANog/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0125', '--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 14:56:30 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/GYqG9k7pSTClgXnwTOANog/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0125 --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 14:56:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zLZ09SFyFy/Render', 14:56:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:56:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:56:30 INFO - 'HOME': '/Users/cltbld', 14:56:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:56:30 INFO - 'LOGNAME': 'cltbld', 14:56:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:56:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:30 INFO - 'MOZ_NO_REMOTE': '1', 14:56:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:56:30 INFO - 'NO_EM_RESTART': '1', 14:56:30 INFO - 'PAGER': '/bin/cat', 14:56:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:30 INFO - 'PWD': '/builds/slave/test', 14:56:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:56:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:56:30 INFO - 'SHELL': '/bin/bash', 14:56:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vg7hV07chT/Listeners', 14:56:30 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 14:56:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:56:30 INFO - 'USER': 'cltbld', 14:56:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:56:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:30 INFO - 'XPC_FLAGS': '0x0', 14:56:30 INFO - 'XPC_SERVICE_NAME': '0', 14:56:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:56:30 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/GYqG9k7pSTClgXnwTOANog/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0125', '--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 14:56:30 INFO - mozversion application_buildid: 20160411131746 14:56:30 INFO - mozversion application_changeset: 1cff2bbb09ff3d87be20c32ceade91b70b40ad40 14:56:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:56:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:56:30 INFO - mozversion application_name: Firefox 14:56:30 INFO - mozversion application_remotingname: firefox-dev 14:56:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:56:30 INFO - mozversion application_vendor: Mozilla 14:56:30 INFO - mozversion application_version: 47.0a2 14:56:30 INFO - mozversion platform_buildid: 20160411131746 14:56:30 INFO - mozversion platform_changeset: 1cff2bbb09ff3d87be20c32ceade91b70b40ad40 14:56:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:56:30 INFO - mozversion platform_version: 47.0a2 14:56:30 INFO - using testdate: 1460411790 14:56:30 INFO - actual date: 1460411790 14:56:30 INFO - starting webserver on 'localhost:49271' 14:56:30 INFO - SUITE-START | Running 2 tests 14:56:30 INFO - TEST-START | dromaeo_css 14:56:30 INFO - operating with platform_type : mac_ 14:56:30 INFO - Initialising browser for dromaeo_css test... 14:56:30 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmpbHhD3K/profile http://localhost:49271/getInfo.html) 14:56:32 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 14:56:32 INFO - PROCESS | 1661 | colorDepth:24 14:56:32 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 14:56:32 INFO - PROCESS | 1661 | __metrics 14:56:32 INFO - PROCESS | 1661 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:56:32 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:56:33 INFO - TEST-INFO | 1661: exit 0 14:56:33 INFO - Browser initialized. 14:56:33 INFO - Running cycle 1/1 for dromaeo_css test... 14:56:33 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmpbHhD3K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:56:45 INFO - PROCESS | 1663 | RSS: Main: 207286272 14:56:45 INFO - PROCESS | 1663 | 14:57:36 INFO - PROCESS | 1663 | 1460411856895 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] 14:59:47 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 14:59:48 INFO - PROCESS | 1663 | RSS: Main: 319045632 14:59:48 INFO - PROCESS | 1663 | 15:02:50 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 15:02:51 INFO - PROCESS | 1663 | RSS: Main: 339484672 15:02:51 INFO - PROCESS | 1663 | 15:05:53 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 15:05:53 INFO - PROCESS | 1663 | RSS: Main: 346984448 15:05:53 INFO - PROCESS | 1663 | 15:08:55 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 15:08:56 INFO - PROCESS | 1663 | RSS: Main: 303730688 15:08:56 INFO - PROCESS | 1663 | 15:11:59 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 15:12:00 INFO - PROCESS | 1663 | RSS: Main: 306786304 15:12:00 INFO - PROCESS | 1663 | 15:15:02 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 15:15:02 INFO - PROCESS | 1663 | RSS: Main: 355311616 15:15:02 INFO - PROCESS | 1663 | 15:15:02 INFO - PROCESS | 1663 | __start_tp_report 15:15:02 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 15:15:02 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 15:15:02 INFO - PROCESS | 1663 | |i|pagename|runs| 15:15:02 INFO - PROCESS | 1663 | |0;dojo.html;3465.497502862085;3500.667436593523;3507.8421471033816;3527.4885141654454;3590.551181102362;5775.191473193756;5792;5817.73820178092;5822.65064096154;5883.529317654583;5805.216295800065;5835.649861008332;5836.474717275444;5852.297724273082;5860.824175274738;5163.948360516403;5213.7132457715;5249.711265880384;5268.130758424855;5322.547583455411;5294.1529355303155;5296;5300.496452836994;5306.044911915854;5311.9468805312035;5218.712970786605;5267.762950667229;5275.86810329741;5288.15389537674;5292.206169074631;5252.395974462928;5307.840764777063;5317.468253174709;5321.893562128775;5336.4930331618825;5050.7222102784335;5212.817551385721;5227.242049902781;5231.503007214346;5242.082635538765;5673.517750991171;5701.173329867188;5701.544355321438;5721.056025755745;5732.484076433099;6144.433169541783;6253.062040693932;6254.280757712876;6267.4672652824565;6269.435750782452;5205.973970130163;6187.257529096492;6217.813465596039;6230.314665386803;6258.06129080637;5890.558208134365;5892.882142357172;5899.852503687443;5911.290645122613;5920.378360272152;6179;6236.594621349598;6303.810885673437;6315.115883776275;6320.209973753281;6208.844778880564;6232.657203853741;6259.624422534572;6263.71813268404;6267.965785645409;6197.597156184924;6210.254769427697;6226.439620434092;6228.813135605939;6241.375862413723;6082.026875699867;6198.721057552421;6210.627362358183;6263.843403914939;6273.9372606273355;6216.906746398808;6237.095621135;6257.5932564383165;6263.154474145932;6270.811875643647;4927.5811556017425;4928.310036594879;4940.530649588283;4942.036302920896;4943.382077240345;4338.934915976263;4375.299952007727;4442.267025940683;4444.466664000341;4447.310666846644;5843.474087332161;5855.707214639337;5859.150423188614;5875.471207591338;5904.232449781501;5249.632525723163;6231.376862313823;6233.3143354231;6236.376362363818;6254.030625253093;5068.949310506921;5638.182463542763;5859.589828712034;5863.736131874076;5892.558058145656;4588.311753237042;5433.8369848904595;5444.5916556258435;5446.074167391553;5449.455054494598;6382.904256436157;6392.0411938209645;6394.744210231632;6396.776112836028;6406.263279722892;6124.625058545733;6163.3528479509005;6182.196314479089;6187.81436556904;6191.349908259568;6357.3006969234275;6382.425581697669;6390.392912673288;6398.90401643985;6409.775657851953;6165.229346331708;6170.845728856814;6190.845228869314;6193.721282542387;6195.4424101831055;6118.223266370805;6181.783637572664;6190.071489276645;6208.720607572761;6234.314225435108;5112.309838171799;5927.585069045125;6160.414760597736;6164.291106522807;6212.161358216583;6133.294671112879;6165.075238714228;6167.013277875519;6201.224846894138;6207.472364849038;5854.092615644582;5959.195508606456;6028.246469191351;6042.818715438368;6063.575549711654;6142.877142457037;6187.969060154671;6195.4424101831055;6213.689315534296;6216.285127210429;5847.239858818326;6008.939910601013;6029.1559181715475;6050.485708714808;6096.634201947897 15:15:02 INFO - PROCESS | 1663 | |1;ext.html;466.51948493052123;581.5492992930479;587.1662239619737;667.1893649216203;668.9096772261214;31985.680143198562;35296.470552941726;37843.621563784356;40073;40489;43857.7807110964;44576;44601.33098003532;44615.553844461545;44669.55330446694;9589.280803939715;9814.50927453628;9826;9830.55762490686;9858.753531161707;9550.37922535033;9689.612415503372;9704.757381065494;9706.70879873605;9721.611135554605;9668.661596844111;9894.455804930725;9911.801763964717;9912.107910288072;9923.801523969516;9837.360571562825;9885.258605604537;9895.604175832957;9905.504724763805;9906.702798916009;9683.031696830261;9797.853032204523;9802.215822734235;9812.90187098127;9928.50357482123;42204;42523.78738106321;42562;42653.786731066146;42657;3228.4673028950197;3353.4969754537015;3359.412102881986;3366.663333666638;3384.4415671414185;29522;29671.109866703817;29754.851225743732;29970.400591988036;30117.397652047057;2728.5361488546996;2754.628125203092;2759.4205216904475;2814.6340975673033;2821.984085729136;429314;432320;432498;434165.82917085214;436206;71815.6409217961;72136.63931680308;72231;72239.63880180671;72256.277437226;75664;75922;78197.43605127865;79555.60222198852;79682.20317796864;17993.7300940486;18071.819281807275;18196.727049094276;18227.362042328456;18248.45254642363;13646.317684115953;13697;13700.725985480234;13757.10578812374;13760.380782864795;22800.885995569915;23044.423889402562;23074.65388019181;23117.653235201484;23151.652725209136;7976.843357713099;9038.683646072355;9097.40866843653;9235.722928312161;9314.534273286308;904.9366544341833;929.7257309093834;996.0836030851634;1119.6473110970019;1154.6593754842343;28575.57136642952;30164.396712065634;30273.394532109236;30674.69325306763;31160.909368172004;1137.1414581990543;1141.1213365708359;1150.039716836451;1189.9702507437382;1201.7596480703894;13142.60572182836;15615.843841561438;15774.13242271686;15794.842051579337;15959;543629;548254;549268;549784;550283;62892;63188;63489.68255158695;63573.68213158905;63635.40911477157;1385.2519639394613;1420.8152940117718;1454.6471781243333;1504.646408094097;1535.2247115206749;29399;29751.958681446045;30284.697153028188;30971.845140774152;30988.535171971987;57640.71179644075;57853;57938;58073;58141.70929145327;364991;376720;377012;377333;378640;40038.39942400924;45711.314330284404;47106.76446617882;47679.76160119177;48466.5153348462;49210;49576;50942;51681.7415912918;51723.482765171866;39864.60135398725;40211;40823.1835363297;40977.59022409738;41435.7928210357;40411.595884040784;40713.59286407098;40847;41038;41845;40518.79740601278;41095.7945210284;41173.588264118174;41928.3710744333;42074.57925420706;31079.533806992462;34175.658243417245;34321.14197144991;34625.480617791254;34659;23055.53888922246;24641.667873172515;25569.977200911755;25931.349752134687;26431.20706378812 15:15:02 INFO - PROCESS | 1663 | |2;jquery.html;333.9347481533907;372.65529385318575;376.2512599926147;378.90337963819223;388.88916658752225;20023.699644505326;20065.899670501665;20277.0875310611;20458.48853778656;20703.585928281424;20485.48786280344;20541.897290513527;21340.8932955335;21378.78621213791;21490.462738431546;5788.392218817026;5950.196723442323;5994.130851026599;5999.76000959961;6000.039993601024;5770.249867517216;5812.9827280226;5918.940810591882;5924.37794031627;5926.170336152942;5837.766489340422;5873.442023007808;5876.882462350751;5878.735456904428;5882;5567.638103523258;5819.883602327951;5838.970805145989;5846.912296315538;5847.853803654943;5067.454426399947;5090;5109.718965456898;5111.2333150027425;5122.948770512322;25187.49625007508;25710.87144564284;26097.608535871976;26165.869170654027;26283.60574591383;2208.2160832904246;2458.4468494588755;2513.522430738154;2831.9521776942456;2845.118013415827;12218;14947.476838310607;14953.476628318065;15080.622984425367;15106;1706.217488233837;1768.2750072470353;1768.7258474936405;1789.5436663650817;1833.3033447290077;92122;94961.52519237429;95354.52322738343;95667.52166239194;96981.51509242479;8586;10322.43226622528;10613.469326533643;10669.57321707123;10757.354558726345;13375.99680024002;13426.731465370638;13454.93272533631;13468.98982576291;13472.663183420493;8659.52372619512;8810.735677929672;8819.338549608678;8889.377743558018;8907.51008694515;9063.773405664911;9073.682421115229;9076.591553380114;9159.450432974043;9205.171534561921;4992.851644121873;6091.451769340781;6096.817095487142;6103.389661033861;6155;1805.4854366505483;1826.7442558041885;1830.6247219320007;1831.395639438982;1833.9633207336046;425.96592272618113;433.9544347843494;981.9509024548744;1056.624898161157;1080.935143891369;11649.068074554016;11824.52701891932;11858.762824743457;11901.88098119025;12032.217905836093;452.2154062701211;465.09538946748927;469.47887844492584;472.5676006454056;474.82668825878994;5438.700871452029;5967.075103358986;6048.516118710492;6099.420555047263;6165.106059621419;592253;606086;625821;628863;633835;120072;120216;128507;129154;132384;477.11971412743435;477.386558272618;482.2982560374646;483.15930281310966;484.5106442493037;11053.834192486958;11565.479553419947;11634.592789252336;11676.88323116758;11756.647300580997;52215.47784522106;52252.126133063044;53124;53310;53773.731131344095;79017;81132.59433702794;81630;83156.16843831484;84744;7963.442559020813;8338.916610834056;8367.95816020916;8462.619182136696;8741.256993155654;12547.811782823082;13301.268430236043;13367.197968121944;13700.177989320673;13758.518451854537;10958.780824383628;11149.777004459704;11550.01824844864;11705.239159454608;11715.472803723682;11283.887161128283;11726.648200553997;11773.234739741889;11780.941095294469;11967.820482692592;11821.527138914347;11833.290002599872;11989.940050300042;12112.515499379926;12131.272123672608;8200.343972482306;8349.290310323691;8535.847660565993;8676.566171691517;8714;10291.43397113136;11915.76168476643;11963.222390544586;12077.698057548632;12086.939565302117 15:15:02 INFO - PROCESS | 1663 | |3;mootools.html;1499.2878382768192;1628.348660535786;1657.8922370045943;1996.5407956170081;2074.128865876331;8430.452020618663;9165.037671044536;9329.160375566198;9330.580123894424;9366.15704586587;8213.589320533963;8943.50810705411;8966.955165224164;8968.327375446836;8969.147930946567;2222.9666555001686;2487.589547724632;2532.493501299743;2563.628273900283;2569.1264969910226;2575.047232523969;2591.2485379239997;2597.1169802267227;2597.2857464197405;2597.714251432341;2182.3125715399597;2437.902483900642;2458.360826185196;2464.3346296499935;2518.534071196825;2511.748825117492;2554.782843458299;2559.5520783862844;2564.910228142006;2570.961435578468;2521.357053951249;2551.553478141318;2560.308716646495;2566.691996960358;2570.5244529762053;9178.541072946326;9236.214921731593;9237.722868313962;9246.260299176118;9264.305177111744;5547.25112109868;5719.7140142992685;5754.482096611283;5758.049921762904;5761.423857614247;3579.928401431983;3648.8175591220597;3685.539307586552;3688.79711615861;3717.9070523236865;1059.099765199582;1073.688630297213;1073.7852429514128;1087.7117563845586;1106.9557217711363;12593.496260149583;12628.179168354027;12629.621111366674;12631.178973366701;12645.367731613474;4556.407667003268;4638.97680511602;4919.3604831371695;4981.701097934136;5058.696478211245;10588.894111058946;10602.787944241227;10606.416647084485;10621.734456638645;10632.096271816827;5650.434956504317;5665.065264231438;5667.574931880125;5675.0636145035605;5678.5741069419955;4539.364488971547;4691.225947718656;4906.239532872411;5087;5146;3387.5765529308837;4039.2123535910805;4093.2222877653153;4151.958480415217;4194.937075943863;1331.7669407853587;1338.718869037513;1348.5166317051362;1352.4657760184673;1358.7893876449166;1376.8141300924447;1399.7340505304164;1405.4659229492931;1408.3028900694221;1433.985660143406;8577.699780507652;8638.78403039929;8654.307655387554;8690.217880390795;8710.956445217733;513.6045245161205;522.3601088666429;527.4830665947393;527.517321650693;528.6880740363205;6339.492840572743;6345.397187267295;6396.744130234739;6409.935900640934;6410.903836442457;11033.337999720043;11599.420028998516;11608.593699220655;11613.419329033515;11614.954654081173;11040.723981900517;11258.38078905668;11300.434978251054;11366.033887119687;11437.313761174357;8754.47473151613;8761.38670293086;8772.824543509221;8852.3803333766;8858.955705221562;8190;8246.628901699318;8280.130586288353;8322.833543328978;8335.916640833513;9999.100080992746;10118.8482172766;10169.288149829441;10243.743906402102;10331.535080921227;10362.585496580052;10524.263301568817;10551;10646.414447205478;10750.784984300426;6981;7154.069970903749;7545.471816972759;7831.530108193527;8354.58227088631;8635.913640863511;8651.48091114535;8703.91296087031;8717.956410217908;8720.65117395297;7494.063242094739;7688.308052275322;7707.92292077072;7760.223977602194;7866.449348545547;7462.141853686896;7464.141623713343;7544.245575442412;7578.242175782378;7700.8459830804195;6768.526203165731;8194.713185038496;8201.95899020501;8209;8223.383246256675;7196.604186769778;7364.447666425147;7367.889481657672;7398.926010739824;7410.407167426485;7498.175200728025;7507.211742766931;7535.434842386733;7536.3970882328185;7545.622718863925 15:15:02 INFO - PROCESS | 1663 | |4;prototype.html;315.7048159970428;324.380433372259;328.67297039445754;334.54835971438547;337.783818356252;6470.482361411082;6540.672966351682;6560.86878262435;6623.2052153741615;6662.300458451866;6501.317361677026;6533.869322613545;6537.21553413591;6545.672716364186;6563.310852360493;3773.207626398446;4691.88270293242;4747.216709242971;4854.635902307315;4856.3201151838775;4835.371401717772;4844.32179494871;4846.806127754903;4847.175980083394;4885.682430642015;4825.493323201066;4850.539198776129;4854.902901941959;4857.781399837016;4863.221884498481;4607.032523170138;4695.248760198352;4779.972305954202;4790.760461976922;4817.927731084036;4104.835806567734;4108.322126849066;4117.938230926538;4120.7321524101135;4123.835046598132;6284.528660350446;6340.270868850095;6350.491960643138;6355.618662880196;6360.586561873463;5757.798477053325;5760.884782304331;5778.335491418498;5792.913106303409;5797.88404231913;6786.117804685359;7035.366816986445;7045.330693584153;7048.18945821232;7048.541844780073;3885.9222815543812;4695.530446955311;4720.386349774507;4722.456917454502;4727.361806156159;6039.9396006039815;7394.852102957911;7460.0674915635545;7460.701571937116;7464.589447580381;4136.86236285024;4711.387519622427;4809.206480930678;4817.686850354716;4830.806767729322;4865.245886887538;4874.341963834908;4882.658213925062;4884.1941079722155;4894.926576101361;5767.711614419262;5782.7686892523825;5782.913256301159;5794.739236734357;5800.419958004166;6768.661566921733;7081.150261968493;7085.078939737904;7094.68073936674;7095.787126386217;1404.761190597601;1652.239969613967;1672.6654669066236;1686.4350442601622;1686.7554204640257;1033.452270296744;1056.9048785609332;1085.1535802074395;1093.5243169221415;1112.4660163121746;6495.610263384212;6606;6629.602223866584;6633.568818026813;6634.734610615618;7358.632068396559;7375.11498620169;7385.224551422023;7387.889181662279;7394.445416593777;6656.966715166393;6668.333166683293;6672.633005184762;6673.132492776005;6688.230853451818;3772.5850156482766;3829.4064420014943;3888.494495715539;3892.630200130983;3896.7077469189926;6025.855087533355;6710.899336509956;7387.556746595222;7644.847103057908;7743.4966727162555;7520;7610.391168706601;7611.847763044819;7618.352440042548;7630.8855367169535;7685.42359323053;7695.6152192390155;7728.033995750531;7732.381409487228;7732.6133693315105;7125.465590080868;7351.338379545867;7352.632368381666;7361.779146625609;7362.6686799093095;7239.384652304402;7276.199618042117;7276.818079548054;7295.927040729524;7308.123025237006;7767.650455729618;7770.494917830323;7773.572453515111;7779.494332868572;7781.471021918012;4014.7189696720948;4597.862064138081;4607.792649330721;4643.8374656886845;4654.534546545318;7054.153501579844;7349.30181632744;7361.1166659999;7361.852762944604;7364.521306115085;7021.438284937295;7042.471814613822;7072.398846098139;7076.7523136692025;7100.0414943981905;7075.5047146699235;7092.326229008236;7095.503314767917;7108.893366599402;7111.395531379684;6937.791866244021;6940.6182659952165;6948.305169483214;6951.9304806953305;6956.40870526011;6863.245043045361;7043.330883566053;7079.823004424725;7098.112735908012;7108.395786358217;6558.376954189344;6709.966450167718;6833.145856767904;6888.827779305558;6953 15:15:02 INFO - PROCESS | 1663 | |5;yui.html;709.5565271705184;758.9127250366208;769.3076231391743;786.8386980668963;794.3645083932852;14914.179720115402;15215.923920380383;15229.543113706593;15231.933764636466;15242.314095865684;14311.35598898052;14507.347169377377;14521.49174778883;14529.636759081028;14544.854551454482;794.4637369775407;798.3054742374143;951.6621599332224;982.4203719805314;986.378581493658;888.5823662878469;944.9574769135405;945.2390825385562;946.7822400847809;961.048561923694;1003.4481035430521;1003.9397636141819;1004.2267454060369;1006.9194464442863;1033.5349092908184;821.3100995164091;825.2160447574768;830.8504469195542;993.8757655293089;1028.9691309260697;617.8053913017385;752.3868047541291;753.8266198774257;758.8140905478193;759.8062494064034;15239.542813715607;15282.235888205656;15307.923460382739;15312.464063757716;15348.92557520974;12690.936545317214;12958.676033099247;13006.804897926539;13246.73506529864;13256.86743132566;9990.486673872263;10049.69850904474;10142.340747851365;10414.895851041469;10470.110040646554;3441.174118211611;3487.9302413951577;3530.858765649371;3580.7672501287593;3738.5700644425965;75429.62285188539;79407;81624.9999999994;82637.17362826355;82882.58558707168;9485.525723713787;9773.46245956465;9821.852672209923;9914.40513569188;9983.251256155818;21364.824934628436;21385;21405.35783926485;21416.78583214179;21462.785372146078;7470.0662417197855;7559.357454616419;7619.276168763959;7696.345810606162;7908.446408751447;4056.148208876169;4117.3618089196225;4134.524529679125;4220.831166753357;4381.846635367747;3747.1194269346684;3781.773093614392;3792.393217085253;3793.886183414502;3797.981010094987;660.6465540935576;676.3540818518303;677.7424578660176;683.9145106861642;685.1333063674456;599.7690889007763;602.4096385542193;617.9567430279927;623.3579413204407;627.6807197405543;7243.840985442409;8258.504489730636;8300.501969881827;8388.622511986854;8454.915450845536;563.391537139888;610.8875280446119;613.1171113596407;617.9104029915727;630.8769789891019;3816.4275358695863;3919.862804801818;3996.2207369562657;3999.7400168988925;4019.638232559084;79776;87245;90527;92687;92986.53506732424;76440;77518;78215;78545;80343.59828200821;56023.719881400335;61662.69168654218;69103.65448172827;70100;70312;7794.493357931717;7899.84200316002;8064.55644939534;8093.35253179756;8101.554414507259;48114.75942620265;48291.27563086486;49637.25544116769;49918;50284;65887.67056164688;72640;73235.63382183055;73450.26549734434;74854;11237.662870113909;11249.268797528135;11273.436328183394;11436.542538298374;11736.70658233551;11924.940375298069;11983.700407489883;12248.142630015813;12267.693307667023;12995.350232488527;11725.472353744273;11909.52361905514;11945.223560468541;12216.144869859025;12295.385230738248;11768.94115529417;11816.527338906348;11887.227330223508;12132.575359862363;12195.817062743889;9757.463339516395;11383.886161138282;11542.13433992437;11903;11988.280703157838;8709.824173736464;9615.855762163434;9745.366551174151;9922.702318930154;9973.650922217688;9640.662576809778;9913.405195688281;9934.602615895283;9959.203263739028;9971.05274998903 15:15:02 INFO - PROCESS | 1663 | __end_tp_report 15:15:02 INFO - PROCESS | 1663 | __start_cc_report 15:15:02 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1056 15:15:02 INFO - PROCESS | 1663 | __end_cc_report 15:15:02 INFO - PROCESS | 1663 | __startTimestamp1460412902980__endTimestamp 15:15:02 INFO - PROCESS | 1663 | 15:15:02 INFO - PROCESS | 1663 | ------- Summary: start ------- 15:15:02 INFO - PROCESS | 1663 | Number of tests: 6 15:15:02 INFO - PROCESS | 1663 | 15:15:02 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5767.87 Median:6008.94 stddev:633.34 (10.5%) stddev-sans-first:608.99 15:15:02 INFO - PROCESS | 1663 | Values: 3465.5 3500.7 3507.8 3527.5 3590.6 5775.2 5792.0 5817.7 5822.7 5883.5 5805.2 5835.6 5836.5 5852.3 5860.8 5163.9 5213.7 5249.7 5268.1 5322.5 5294.2 5296.0 5300.5 5306.0 5311.9 5218.7 5267.8 5275.9 5288.2 5292.2 5252.4 5307.8 5317.5 5321.9 5336.5 5050.7 5212.8 5227.2 5231.5 5242.1 5673.5 5701.2 5701.5 5721.1 5732.5 6144.4 6253.1 6254.3 6267.5 6269.4 5206.0 6187.3 6217.8 6230.3 6258.1 5890.6 5892.9 5899.9 5911.3 5920.4 6179.0 6236.6 6303.8 6315.1 6320.2 6208.8 6232.7 6259.6 6263.7 6268.0 6197.6 6210.3 6226.4 6228.8 6241.4 6082.0 6198.7 6210.6 6263.8 6273.9 6216.9 6237.1 6257.6 6263.2 6270.8 4927.6 4928.3 4940.5 4942.0 4943.4 4338.9 4375.3 4442.3 4444.5 4447.3 5843.5 5855.7 5859.2 5875.5 5904.2 5249.6 6231.4 6233.3 6236.4 6254.0 5068.9 5638.2 5859.6 5863.7 5892.6 4588.3 5433.8 5444.6 5446.1 5449.5 6382.9 6392.0 6394.7 6396.8 6406.3 6124.6 6163.4 6182.2 6187.8 6191.3 6357.3 6382.4 6390.4 6398.9 6409.8 6165.2 6170.8 6190.8 6193.7 6195.4 6118.2 6181.8 6190.1 6208.7 6234.3 5112.3 5927.6 6160.4 6164.3 6212.2 6133.3 6165.1 6167.0 6201.2 6207.5 5854.1 5959.2 6028.2 6042.8 6063.6 6142.9 6188.0 6195.4 6213.7 6216.3 5847.2 6008.9 6029.2 6050.5 6096.6 15:15:02 INFO - PROCESS | 1663 | 15:15:02 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:62734.91 Median:41886.69 stddev:121303.73 (289.6%) stddev-sans-first:121553.92 15:15:02 INFO - PROCESS | 1663 | Values: 466.5 581.5 587.2 667.2 668.9 31985.7 35296.5 37843.6 40073.0 40489.0 43857.8 44576.0 44601.3 44615.6 44669.6 9589.3 9814.5 9826.0 9830.6 9858.8 9550.4 9689.6 9704.8 9706.7 9721.6 9668.7 9894.5 9911.8 9912.1 9923.8 9837.4 9885.3 9895.6 9905.5 9906.7 9683.0 9797.9 9802.2 9812.9 9928.5 42204.0 42523.8 42562.0 42653.8 42657.0 3228.5 3353.5 3359.4 3366.7 3384.4 29522.0 29671.1 29754.9 29970.4 30117.4 2728.5 2754.6 2759.4 2814.6 2822.0 429314.0 432320.0 432498.0 434165.8 436206.0 71815.6 72136.6 72231.0 72239.6 72256.3 75664.0 75922.0 78197.4 79555.6 79682.2 17993.7 18071.8 18196.7 18227.4 18248.5 13646.3 13697.0 13700.7 13757.1 13760.4 22800.9 23044.4 23074.7 23117.7 23151.7 7976.8 9038.7 9097.4 9235.7 9314.5 904.9 929.7 996.1 1119.6 1154.7 28575.6 30164.4 30273.4 30674.7 31160.9 1137.1 1141.1 1150.0 1190.0 1201.8 13142.6 15615.8 15774.1 15794.8 15959.0 543629.0 548254.0 549268.0 549784.0 550283.0 62892.0 63188.0 63489.7 63573.7 63635.4 1385.3 1420.8 1454.6 1504.6 1535.2 29399.0 29752.0 30284.7 30971.8 30988.5 57640.7 57853.0 57938.0 58073.0 58141.7 364991.0 376720.0 377012.0 377333.0 378640.0 40038.4 45711.3 47106.8 47679.8 48466.5 49210.0 49576.0 50942.0 51681.7 51723.5 39864.6 40211.0 40823.2 40977.6 41435.8 40411.6 40713.6 40847.0 41038.0 41845.0 40518.8 41095.8 41173.6 41928.4 42074.6 31079.5 34175.7 34321.1 34625.5 34659.0 23055.5 24641.7 25570.0 25931.3 26431.2 15:15:02 INFO - PROCESS | 1663 | 15:15:02 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:34601.19 Median:407.43 stddev:102528.72 (25164.9%) stddev-sans-first:102784.05 15:15:03 INFO - PROCESS | 1663 | Values: 333.9 372.7 376.3 378.9 388.9 20023.7 20065.9 20277.1 20458.5 20703.6 20485.5 20541.9 21340.9 21378.8 21490.5 5788.4 5950.2 5994.1 5999.8 6000.0 5770.2 5813.0 5918.9 5924.4 5926.2 5837.8 5873.4 5876.9 5878.7 5882.0 5567.6 5819.9 5839.0 5846.9 5847.9 5067.5 5090.0 5109.7 5111.2 5122.9 25187.5 25710.9 26097.6 26165.9 26283.6 2208.2 2458.4 2513.5 2832.0 2845.1 12218.0 14947.5 14953.5 15080.6 15106.0 1706.2 1768.3 1768.7 1789.5 1833.3 92122.0 94961.5 95354.5 95667.5 96981.5 8586.0 10322.4 10613.5 10669.6 10757.4 13376.0 13426.7 13454.9 13469.0 13472.7 8659.5 8810.7 8819.3 8889.4 8907.5 9063.8 9073.7 9076.6 9159.5 9205.2 4992.9 6091.5 6096.8 6103.4 6155.0 1805.5 1826.7 1830.6 1831.4 1834.0 426.0 434.0 982.0 1056.6 1080.9 11649.1 11824.5 11858.8 11901.9 12032.2 452.2 465.1 469.5 472.6 474.8 5438.7 5967.1 6048.5 6099.4 6165.1 592253.0 606086.0 625821.0 628863.0 633835.0 120072.0 120216.0 128507.0 129154.0 132384.0 477.1 477.4 482.3 483.2 484.5 11053.8 11565.5 11634.6 11676.9 11756.6 52215.5 52252.1 53124.0 53310.0 53773.7 79017.0 81132.6 81630.0 83156.2 84744.0 7963.4 8338.9 8368.0 8462.6 8741.3 12547.8 13301.3 13367.2 13700.2 13758.5 10958.8 11149.8 11550.0 11705.2 11715.5 11283.9 11726.6 11773.2 11780.9 11967.8 11821.5 11833.3 11989.9 12112.5 12131.3 8200.3 8349.3 8535.8 8676.6 8714.0 10291.4 11915.8 11963.2 12077.7 12086.9 15:15:03 INFO - PROCESS | 1663 | 15:15:03 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:6326.77 Median:5020.20 stddev:3416.62 (68.1%) stddev-sans-first:3406.94 15:15:03 INFO - PROCESS | 1663 | Values: 1499.3 1628.3 1657.9 1996.5 2074.1 8430.5 9165.0 9329.2 9330.6 9366.2 8213.6 8943.5 8967.0 8968.3 8969.1 2223.0 2487.6 2532.5 2563.6 2569.1 2575.0 2591.2 2597.1 2597.3 2597.7 2182.3 2437.9 2458.4 2464.3 2518.5 2511.7 2554.8 2559.6 2564.9 2571.0 2521.4 2551.6 2560.3 2566.7 2570.5 9178.5 9236.2 9237.7 9246.3 9264.3 5547.3 5719.7 5754.5 5758.0 5761.4 3579.9 3648.8 3685.5 3688.8 3717.9 1059.1 1073.7 1073.8 1087.7 1107.0 12593.5 12628.2 12629.6 12631.2 12645.4 4556.4 4639.0 4919.4 4981.7 5058.7 10588.9 10602.8 10606.4 10621.7 10632.1 5650.4 5665.1 5667.6 5675.1 5678.6 4539.4 4691.2 4906.2 5087.0 5146.0 3387.6 4039.2 4093.2 4152.0 4194.9 1331.8 1338.7 1348.5 1352.5 1358.8 1376.8 1399.7 1405.5 1408.3 1434.0 8577.7 8638.8 8654.3 8690.2 8711.0 513.6 522.4 527.5 527.5 528.7 6339.5 6345.4 6396.7 6409.9 6410.9 11033.3 11599.4 11608.6 11613.4 11615.0 11040.7 11258.4 11300.4 11366.0 11437.3 8754.5 8761.4 8772.8 8852.4 8859.0 8190.0 8246.6 8280.1 8322.8 8335.9 9999.1 10118.8 10169.3 10243.7 10331.5 10362.6 10524.3 10551.0 10646.4 10750.8 6981.0 7154.1 7545.5 7831.5 8354.6 8635.9 8651.5 8703.9 8718.0 8720.7 7494.1 7688.3 7707.9 7760.2 7866.4 7462.1 7464.1 7544.2 7578.2 7700.8 6768.5 8194.7 8202.0 8209.0 8223.4 7196.6 7364.4 7367.9 7398.9 7410.4 7498.2 7507.2 7535.4 7536.4 7545.6 15:15:03 INFO - PROCESS | 1663 | 15:15:03 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:5790.89 Median:6562.09 stddev:1859.66 (28.3%) stddev-sans-first:1818.90 15:15:03 INFO - PROCESS | 1663 | Values: 315.7 324.4 328.7 334.5 337.8 6470.5 6540.7 6560.9 6623.2 6662.3 6501.3 6533.9 6537.2 6545.7 6563.3 3773.2 4691.9 4747.2 4854.6 4856.3 4835.4 4844.3 4846.8 4847.2 4885.7 4825.5 4850.5 4854.9 4857.8 4863.2 4607.0 4695.2 4780.0 4790.8 4817.9 4104.8 4108.3 4117.9 4120.7 4123.8 6284.5 6340.3 6350.5 6355.6 6360.6 5757.8 5760.9 5778.3 5792.9 5797.9 6786.1 7035.4 7045.3 7048.2 7048.5 3885.9 4695.5 4720.4 4722.5 4727.4 6039.9 7394.9 7460.1 7460.7 7464.6 4136.9 4711.4 4809.2 4817.7 4830.8 4865.2 4874.3 4882.7 4884.2 4894.9 5767.7 5782.8 5782.9 5794.7 5800.4 6768.7 7081.2 7085.1 7094.7 7095.8 1404.8 1652.2 1672.7 1686.4 1686.8 1033.5 1056.9 1085.2 1093.5 1112.5 6495.6 6606.0 6629.6 6633.6 6634.7 7358.6 7375.1 7385.2 7387.9 7394.4 6657.0 6668.3 6672.6 6673.1 6688.2 3772.6 3829.4 3888.5 3892.6 3896.7 6025.9 6710.9 7387.6 7644.8 7743.5 7520.0 7610.4 7611.8 7618.4 7630.9 7685.4 7695.6 7728.0 7732.4 7732.6 7125.5 7351.3 7352.6 7361.8 7362.7 7239.4 7276.2 7276.8 7295.9 7308.1 7767.7 7770.5 7773.6 7779.5 7781.5 4014.7 4597.9 4607.8 4643.8 4654.5 7054.2 7349.3 7361.1 7361.9 7364.5 7021.4 7042.5 7072.4 7076.8 7100.0 7075.5 7092.3 7095.5 7108.9 7111.4 6937.8 6940.6 6948.3 6951.9 6956.4 6863.2 7043.3 7079.8 7098.1 7108.4 6558.4 6710.0 6833.1 6888.8 6953.0 15:15:03 INFO - PROCESS | 1663 | 15:15:03 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:18282.67 Median:31140.25 stddev:25357.41 (81.4%) stddev-sans-first:25394.21 15:15:03 INFO - PROCESS | 1663 | Values: 709.6 758.9 769.3 786.8 794.4 14914.2 15215.9 15229.5 15231.9 15242.3 14311.4 14507.3 14521.5 14529.6 14544.9 794.5 798.3 951.7 982.4 986.4 888.6 945.0 945.2 946.8 961.0 1003.4 1003.9 1004.2 1006.9 1033.5 821.3 825.2 830.9 993.9 1029.0 617.8 752.4 753.8 758.8 759.8 15239.5 15282.2 15307.9 15312.5 15348.9 12690.9 12958.7 13006.8 13246.7 13256.9 9990.5 10049.7 10142.3 10414.9 10470.1 3441.2 3487.9 3530.9 3580.8 3738.6 75429.6 79407.0 81625.0 82637.2 82882.6 9485.5 9773.5 9821.9 9914.4 9983.3 21364.8 21385.0 21405.4 21416.8 21462.8 7470.1 7559.4 7619.3 7696.3 7908.4 4056.1 4117.4 4134.5 4220.8 4381.8 3747.1 3781.8 3792.4 3793.9 3798.0 660.6 676.4 677.7 683.9 685.1 599.8 602.4 618.0 623.4 627.7 7243.8 8258.5 8300.5 8388.6 8454.9 563.4 610.9 613.1 617.9 630.9 3816.4 3919.9 3996.2 3999.7 4019.6 79776.0 87245.0 90527.0 92687.0 92986.5 76440.0 77518.0 78215.0 78545.0 80343.6 56023.7 61662.7 69103.7 70100.0 70312.0 7794.5 7899.8 8064.6 8093.4 8101.6 48114.8 48291.3 49637.3 49918.0 50284.0 65887.7 72640.0 73235.6 73450.3 74854.0 11237.7 11249.3 11273.4 11436.5 11736.7 11924.9 11983.7 12248.1 12267.7 12995.4 11725.5 11909.5 11945.2 12216.1 12295.4 11768.9 11816.5 11887.2 12132.6 12195.8 9757.5 11383.9 11542.1 11903.0 11988.3 8709.8 9615.9 9745.4 9922.7 9973.7 9640.7 9913.4 9934.6 9959.2 9971.1 15:15:03 INFO - PROCESS | 1663 | -------- Summary: end -------- 15:15:03 INFO - PROCESS | 1663 | 15:15:03 INFO - TEST-INFO | 1663: exit 0 15:15:03 INFO - TEST-OK | dromaeo_css | took 1113038ms 15:15:03 INFO - TEST-START | kraken 15:15:03 INFO - operating with platform_type : mac_ 15:15:03 INFO - Initialising browser for kraken test... 15:15:03 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmphHAdvf/profile http://localhost:49271/getInfo.html) 15:15:05 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 15:15:05 INFO - PROCESS | 1669 | colorDepth:24 15:15:05 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 15:15:05 INFO - PROCESS | 1669 | __metrics 15:15:05 INFO - PROCESS | 1669 | 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" 15:15:05 INFO - PROCESS | 1669 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:15:06 INFO - TEST-INFO | 1669: exit 0 15:15:06 INFO - Browser initialized. 15:15:06 INFO - Running cycle 1/1 for kraken test... 15:15:06 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmphHAdvf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:15:18 INFO - PROCESS | 1671 | RSS: Main: 207364096 15:15:18 INFO - PROCESS | 1671 | 15:15:20 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 15:15:21 INFO - PROCESS | 1671 | RSS: Main: 262885376 15:15:21 INFO - PROCESS | 1671 | 15:15:24 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 15:15:24 INFO - PROCESS | 1671 | RSS: Main: 273436672 15:15:24 INFO - PROCESS | 1671 | 15:15:27 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 15:15:28 INFO - PROCESS | 1671 | RSS: Main: 264126464 15:15:28 INFO - PROCESS | 1671 | 15:15:30 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 15:15:31 INFO - PROCESS | 1671 | RSS: Main: 265019392 15:15:31 INFO - PROCESS | 1671 | 15:15:33 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:15:33 INFO - PROCESS | 1671 | RSS: Main: 264839168 15:15:33 INFO - PROCESS | 1671 | 15:15:36 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 15:15:37 INFO - PROCESS | 1671 | RSS: Main: 266022912 15:15:37 INFO - PROCESS | 1671 | 15:15:39 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 15:15:40 INFO - PROCESS | 1671 | RSS: Main: 266170368 15:15:40 INFO - PROCESS | 1671 | 15:15:43 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 15:15:43 INFO - PROCESS | 1671 | RSS: Main: 266764288 15:15:43 INFO - PROCESS | 1671 | 15:15:45 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:15:45 INFO - PROCESS | 1671 | RSS: Main: 299192320 15:15:45 INFO - PROCESS | 1671 | 15:15:47 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:15:48 INFO - PROCESS | 1671 | RSS: Main: 300138496 15:15:48 INFO - PROCESS | 1671 | 15:15:50 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:15:51 INFO - PROCESS | 1671 | RSS: Main: 304816128 15:15:51 INFO - PROCESS | 1671 | 15:15:53 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:15:54 INFO - PROCESS | 1671 | RSS: Main: 306806784 15:15:54 INFO - PROCESS | 1671 | 15:15:56 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:15:57 INFO - PROCESS | 1671 | RSS: Main: 306675712 15:15:57 INFO - PROCESS | 1671 | 15:15:58 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 15:15:59 INFO - PROCESS | 1671 | RSS: Main: 368939008 15:15:59 INFO - PROCESS | 1671 | 15:15:59 INFO - PROCESS | 1671 | __start_tp_report 15:15:59 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 15:15:59 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 15:15:59 INFO - PROCESS | 1671 | |i|pagename|runs| 15:15:59 INFO - PROCESS | 1671 | |0;ai-astar;113;108;110;136;158;162;121;110;111;112 15:15:59 INFO - PROCESS | 1671 | |1;audio-beat-detection;151;119;152;144;115;136;116;149;148;117 15:15:59 INFO - PROCESS | 1671 | |2;audio-dft;187;186;198;261;207;185;185;186;185;185 15:15:59 INFO - PROCESS | 1671 | |3;audio-fft;75;74;75;120;60;83;46;54;128;55 15:15:59 INFO - PROCESS | 1671 | |4;audio-oscillator;90;95;127;77;81;87;117;76;77;119 15:15:59 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;87;83;87;84;86;83;88;84;86;86 15:15:59 INFO - PROCESS | 1671 | |6;imaging-darkroom;93;93;94;93;93;93;93;94;93;93 15:15:59 INFO - PROCESS | 1671 | |7;imaging-desaturate;87;86;96;116;86;87;94;86;85;88 15:15:59 INFO - PROCESS | 1671 | |8;json-parse-financial;53;58;57;57;57;58;58;68;51;52 15:15:59 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;61;62;68;66;78;72;66;64;65;67 15:15:59 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;81;81;81;80;82;83;97;104;81;85 15:15:59 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;134;127;123;133;129;119;132;113;122;130 15:15:59 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;132;121;117;134;161;149;176;154;132;134 15:15:59 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;66;67;65;66;66;66;64;61;66;65 15:15:59 INFO - PROCESS | 1671 | __end_tp_report 15:15:59 INFO - PROCESS | 1671 | __start_cc_report 15:15:59 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1208 15:15:59 INFO - PROCESS | 1671 | __end_cc_report 15:15:59 INFO - PROCESS | 1671 | __startTimestamp1460412959190__endTimestamp 15:15:59 INFO - PROCESS | 1671 | 15:15:59 INFO - PROCESS | 1671 | ------- Summary: start ------- 15:15:59 INFO - PROCESS | 1671 | Number of tests: 14 15:15:59 INFO - PROCESS | 1671 | 15:15:59 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:124.10 Median:117.00 stddev:20.64 (17.6%) stddev-sans-first:21.50 15:15:59 INFO - PROCESS | 1671 | Values: 113.0 108.0 110.0 136.0 158.0 162.0 121.0 110.0 111.0 112.0 15:15:59 INFO - PROCESS | 1671 | 15:15:59 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:146.00 stddev:16.10 (11.0%) stddev-sans-first:15.96 15:15:59 INFO - PROCESS | 1671 | Values: 151.0 119.0 152.0 144.0 115.0 136.0 116.0 149.0 148.0 117.0 15:15:59 INFO - PROCESS | 1671 | 15:15:59 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:196.50 Median:186.50 stddev:23.83 (12.8%) stddev-sans-first:25.03 15:15:59 INFO - PROCESS | 1671 | Values: 187.0 186.0 198.0 261.0 207.0 185.0 185.0 186.0 185.0 185.0 15:15:59 INFO - PROCESS | 1671 | 15:15:59 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:77.00 Median:67.00 stddev:27.42 (40.9%) stddev-sans-first:29.07 15:15:59 INFO - PROCESS | 1671 | Values: 75.0 74.0 75.0 120.0 60.0 83.0 46.0 54.0 128.0 55.0 15:15:59 INFO - PROCESS | 1671 | 15:15:59 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:79.00 stddev:19.37 (24.5%) stddev-sans-first:20.47 15:15:59 INFO - PROCESS | 1671 | Values: 90.0 95.0 127.0 77.0 81.0 87.0 117.0 76.0 77.0 119.0 15:15:59 INFO - PROCESS | 1671 | 15:15:59 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:85.40 Median:86.00 stddev:1.78 (2.1%) stddev-sans-first:1.79 15:15:59 INFO - PROCESS | 1671 | Values: 87.0 83.0 87.0 84.0 86.0 83.0 88.0 84.0 86.0 86.0 15:15:59 INFO - PROCESS | 1671 | 15:15:59 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 15:15:59 INFO - PROCESS | 1671 | Values: 93.0 93.0 94.0 93.0 93.0 93.0 93.0 94.0 93.0 93.0 15:15:59 INFO - PROCESS | 1671 | 15:15:59 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:91.10 Median:87.00 stddev:9.49 (10.9%) stddev-sans-first:9.95 15:15:59 INFO - PROCESS | 1671 | Values: 87.0 86.0 96.0 116.0 86.0 87.0 94.0 86.0 85.0 88.0 15:15:59 INFO - PROCESS | 1671 | 15:15:59 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.50 stddev:4.72 (8.2%) stddev-sans-first:4.80 15:15:59 INFO - PROCESS | 1671 | Values: 53.0 58.0 57.0 57.0 57.0 58.0 58.0 68.0 51.0 52.0 15:15:59 INFO - PROCESS | 1671 | 15:15:59 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:66.50 stddev:4.98 (7.5%) stddev-sans-first:4.80 15:15:59 INFO - PROCESS | 1671 | Values: 61.0 62.0 68.0 66.0 78.0 72.0 66.0 64.0 65.0 67.0 15:15:59 INFO - PROCESS | 1671 | 15:15:59 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:81.50 stddev:8.20 (10.1%) stddev-sans-first:8.53 15:15:59 INFO - PROCESS | 1671 | Values: 81.0 81.0 81.0 80.0 82.0 83.0 97.0 104.0 81.0 85.0 15:15:59 INFO - PROCESS | 1671 | 15:15:59 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:129.50 stddev:6.81 (5.3%) stddev-sans-first:6.61 15:15:59 INFO - PROCESS | 1671 | Values: 134.0 127.0 123.0 133.0 129.0 119.0 132.0 113.0 122.0 130.0 15:15:59 INFO - PROCESS | 1671 | 15:15:59 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.00 Median:141.50 stddev:18.54 (13.1%) stddev-sans-first:19.38 15:15:59 INFO - PROCESS | 1671 | Values: 132.0 121.0 117.0 134.0 161.0 149.0 176.0 154.0 132.0 134.0 15:15:59 INFO - PROCESS | 1671 | 15:15:59 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:66.00 stddev:1.69 (2.6%) stddev-sans-first:1.76 15:15:59 INFO - PROCESS | 1671 | Values: 66.0 67.0 65.0 66.0 66.0 66.0 64.0 61.0 66.0 65.0 15:15:59 INFO - PROCESS | 1671 | -------- Summary: end -------- 15:15:59 INFO - PROCESS | 1671 | 15:15:59 INFO - TEST-INFO | 1671: exit 0 15:15:59 INFO - TEST-OK | kraken | took 56464ms 15:15:59 INFO - SUITE-END | took 1169s 15:16:00 INFO - Completed test suite (00:19:29) 15:16:00 INFO - javascript benchmark 15:16:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3465.497502862085, 3500.667436593523, 3507.8421471033816, 3527.4885141654454, 3590.551181102362, 5775.191473193756, 5792.0, 5817.73820178092, 5822.65064096154, 5883.529317654583, 5805.216295800065, 5835.649861008332, 5836.474717275444, 5852.297724273082, 5860.824175274738, 5163.948360516403, 5213.7132457715, 5249.711265880384, 5268.130758424855, 5322.547583455411, 5294.1529355303155, 5296.0, 5300.496452836994, 5306.044911915854, 5311.9468805312035, 5218.712970786605, 5267.762950667229, 5275.86810329741, 5288.15389537674, 5292.206169074631, 5252.395974462928, 5307.840764777063, 5317.468253174709, 5321.893562128775, 5336.4930331618825, 5050.7222102784335, 5212.817551385721, 5227.242049902781, 5231.503007214346, 5242.082635538765, 5673.517750991171, 5701.173329867188, 5701.544355321438, 5721.056025755745, 5732.484076433099, 6144.433169541783, 6253.062040693932, 6254.280757712876, 6267.4672652824565, 6269.435750782452, 5205.973970130163, 6187.257529096492, 6217.813465596039, 6230.314665386803, 6258.06129080637, 5890.558208134365, 5892.882142357172, 5899.852503687443, 5911.290645122613, 5920.378360272152, 6179.0, 6236.594621349598, 6303.810885673437, 6315.115883776275, 6320.209973753281, 6208.844778880564, 6232.657203853741, 6259.624422534572, 6263.71813268404, 6267.965785645409, 6197.597156184924, 6210.254769427697, 6226.439620434092, 6228.813135605939, 6241.375862413723, 6082.026875699867, 6198.721057552421, 6210.627362358183, 6263.843403914939, 6273.9372606273355, 6216.906746398808, 6237.095621135, 6257.5932564383165, 6263.154474145932, 6270.811875643647, 4927.5811556017425, 4928.310036594879, 4940.530649588283, 4942.036302920896, 4943.382077240345, 4338.934915976263, 4375.299952007727, 4442.267025940683, 4444.466664000341, 4447.310666846644, 5843.474087332161, 5855.707214639337, 5859.150423188614, 5875.471207591338, 5904.232449781501, 5249.632525723163, 6231.376862313823, 6233.3143354231, 6236.376362363818, 6254.030625253093, 5068.949310506921, 5638.182463542763, 5859.589828712034, 5863.736131874076, 5892.558058145656, 4588.311753237042, 5433.8369848904595, 5444.5916556258435, 5446.074167391553, 5449.455054494598, 6382.904256436157, 6392.0411938209645, 6394.744210231632, 6396.776112836028, 6406.263279722892, 6124.625058545733, 6163.3528479509005, 6182.196314479089, 6187.81436556904, 6191.349908259568, 6357.3006969234275, 6382.425581697669, 6390.392912673288, 6398.90401643985, 6409.775657851953, 6165.229346331708, 6170.845728856814, 6190.845228869314, 6193.721282542387, 6195.4424101831055, 6118.223266370805, 6181.783637572664, 6190.071489276645, 6208.720607572761, 6234.314225435108, 5112.309838171799, 5927.585069045125, 6160.414760597736, 6164.291106522807, 6212.161358216583, 6133.294671112879, 6165.075238714228, 6167.013277875519, 6201.224846894138, 6207.472364849038, 5854.092615644582, 5959.195508606456, 6028.246469191351, 6042.818715438368, 6063.575549711654, 6142.877142457037, 6187.969060154671, 6195.4424101831055, 6213.689315534296, 6216.285127210429, 5847.239858818326, 6008.939910601013, 6029.1559181715475, 6050.485708714808, 6096.634201947897], "unit": "score", "name": "dojo.html", "value": 5729.5453149174955}, {"lowerIsBetter": false, "replicates": [466.51948493052123, 581.5492992930479, 587.1662239619737, 667.1893649216203, 668.9096772261214, 31985.680143198562, 35296.470552941726, 37843.621563784356, 40073.0, 40489.0, 43857.7807110964, 44576.0, 44601.33098003532, 44615.553844461545, 44669.55330446694, 9589.280803939715, 9814.50927453628, 9826.0, 9830.55762490686, 9858.753531161707, 9550.37922535033, 9689.612415503372, 9704.757381065494, 9706.70879873605, 9721.611135554605, 9668.661596844111, 9894.455804930725, 9911.801763964717, 9912.107910288072, 9923.801523969516, 9837.360571562825, 9885.258605604537, 9895.604175832957, 9905.504724763805, 9906.702798916009, 9683.031696830261, 9797.853032204523, 9802.215822734235, 9812.90187098127, 9928.50357482123, 42204.0, 42523.78738106321, 42562.0, 42653.786731066146, 42657.0, 3228.4673028950197, 3353.4969754537015, 3359.412102881986, 3366.663333666638, 3384.4415671414185, 29522.0, 29671.109866703817, 29754.851225743732, 29970.400591988036, 30117.397652047057, 2728.5361488546996, 2754.628125203092, 2759.4205216904475, 2814.6340975673033, 2821.984085729136, 429314.0, 432320.0, 432498.0, 434165.82917085214, 436206.0, 71815.6409217961, 72136.63931680308, 72231.0, 72239.63880180671, 72256.277437226, 75664.0, 75922.0, 78197.43605127865, 79555.60222198852, 79682.20317796864, 17993.7300940486, 18071.819281807275, 18196.727049094276, 18227.362042328456, 18248.45254642363, 13646.317684115953, 13697.0, 13700.725985480234, 13757.10578812374, 13760.380782864795, 22800.885995569915, 23044.423889402562, 23074.65388019181, 23117.653235201484, 23151.652725209136, 7976.843357713099, 9038.683646072355, 9097.40866843653, 9235.722928312161, 9314.534273286308, 904.9366544341833, 929.7257309093834, 996.0836030851634, 1119.6473110970019, 1154.6593754842343, 28575.57136642952, 30164.396712065634, 30273.394532109236, 30674.69325306763, 31160.909368172004, 1137.1414581990543, 1141.1213365708359, 1150.039716836451, 1189.9702507437382, 1201.7596480703894, 13142.60572182836, 15615.843841561438, 15774.13242271686, 15794.842051579337, 15959.0, 543629.0, 548254.0, 549268.0, 549784.0, 550283.0, 62892.0, 63188.0, 63489.68255158695, 63573.68213158905, 63635.40911477157, 1385.2519639394613, 1420.8152940117718, 1454.6471781243333, 1504.646408094097, 1535.2247115206749, 29399.0, 29751.958681446045, 30284.697153028188, 30971.845140774152, 30988.535171971987, 57640.71179644075, 57853.0, 57938.0, 58073.0, 58141.70929145327, 364991.0, 376720.0, 377012.0, 377333.0, 378640.0, 40038.39942400924, 45711.314330284404, 47106.76446617882, 47679.76160119177, 48466.5153348462, 49210.0, 49576.0, 50942.0, 51681.7415912918, 51723.482765171866, 39864.60135398725, 40211.0, 40823.1835363297, 40977.59022409738, 41435.7928210357, 40411.595884040784, 40713.59286407098, 40847.0, 41038.0, 41845.0, 40518.79740601278, 41095.7945210284, 41173.588264118174, 41928.3710744333, 42074.57925420706, 31079.533806992462, 34175.658243417245, 34321.14197144991, 34625.480617791254, 34659.0, 23055.53888922246, 24641.667873172515, 25569.977200911755, 25931.349752134687, 26431.20706378812], "unit": "score", "name": "ext.html", "value": 20877.47953882264}, {"lowerIsBetter": false, "replicates": [333.9347481533907, 372.65529385318575, 376.2512599926147, 378.90337963819223, 388.88916658752225, 20023.699644505326, 20065.899670501665, 20277.0875310611, 20458.48853778656, 20703.585928281424, 20485.48786280344, 20541.897290513527, 21340.8932955335, 21378.78621213791, 21490.462738431546, 5788.392218817026, 5950.196723442323, 5994.130851026599, 5999.76000959961, 6000.039993601024, 5770.249867517216, 5812.9827280226, 5918.940810591882, 5924.37794031627, 5926.170336152942, 5837.766489340422, 5873.442023007808, 5876.882462350751, 5878.735456904428, 5882.0, 5567.638103523258, 5819.883602327951, 5838.970805145989, 5846.912296315538, 5847.853803654943, 5067.454426399947, 5090.0, 5109.718965456898, 5111.2333150027425, 5122.948770512322, 25187.49625007508, 25710.87144564284, 26097.608535871976, 26165.869170654027, 26283.60574591383, 2208.2160832904246, 2458.4468494588755, 2513.522430738154, 2831.9521776942456, 2845.118013415827, 12218.0, 14947.476838310607, 14953.476628318065, 15080.622984425367, 15106.0, 1706.217488233837, 1768.2750072470353, 1768.7258474936405, 1789.5436663650817, 1833.3033447290077, 92122.0, 94961.52519237429, 95354.52322738343, 95667.52166239194, 96981.51509242479, 8586.0, 10322.43226622528, 10613.469326533643, 10669.57321707123, 10757.354558726345, 13375.99680024002, 13426.731465370638, 13454.93272533631, 13468.98982576291, 13472.663183420493, 8659.52372619512, 8810.735677929672, 8819.338549608678, 8889.377743558018, 8907.51008694515, 9063.773405664911, 9073.682421115229, 9076.591553380114, 9159.450432974043, 9205.171534561921, 4992.851644121873, 6091.451769340781, 6096.817095487142, 6103.389661033861, 6155.0, 1805.4854366505483, 1826.7442558041885, 1830.6247219320007, 1831.395639438982, 1833.9633207336046, 425.96592272618113, 433.9544347843494, 981.9509024548744, 1056.624898161157, 1080.935143891369, 11649.068074554016, 11824.52701891932, 11858.762824743457, 11901.88098119025, 12032.217905836093, 452.2154062701211, 465.09538946748927, 469.47887844492584, 472.5676006454056, 474.82668825878994, 5438.700871452029, 5967.075103358986, 6048.516118710492, 6099.420555047263, 6165.106059621419, 592253.0, 606086.0, 625821.0, 628863.0, 633835.0, 120072.0, 120216.0, 128507.0, 129154.0, 132384.0, 477.11971412743435, 477.386558272618, 482.2982560374646, 483.15930281310966, 484.5106442493037, 11053.834192486958, 11565.479553419947, 11634.592789252336, 11676.88323116758, 11756.647300580997, 52215.47784522106, 52252.126133063044, 53124.0, 53310.0, 53773.731131344095, 79017.0, 81132.59433702794, 81630.0, 83156.16843831484, 84744.0, 7963.442559020813, 8338.916610834056, 8367.95816020916, 8462.619182136696, 8741.256993155654, 12547.811782823082, 13301.268430236043, 13367.197968121944, 13700.177989320673, 13758.518451854537, 10958.780824383628, 11149.777004459704, 11550.01824844864, 11705.239159454608, 11715.472803723682, 11283.887161128283, 11726.648200553997, 11773.234739741889, 11780.941095294469, 11967.820482692592, 11821.527138914347, 11833.290002599872, 11989.940050300042, 12112.515499379926, 12131.272123672608, 8200.343972482306, 8349.290310323691, 8535.847660565993, 8676.566171691517, 8714.0, 10291.43397113136, 11915.76168476643, 11963.222390544586, 12077.698057548632, 12086.939565302117], "unit": "score", "name": "jquery.html", "value": 8916.025141013853}, {"lowerIsBetter": false, "replicates": [1499.2878382768192, 1628.348660535786, 1657.8922370045943, 1996.5407956170081, 2074.128865876331, 8430.452020618663, 9165.037671044536, 9329.160375566198, 9330.580123894424, 9366.15704586587, 8213.589320533963, 8943.50810705411, 8966.955165224164, 8968.327375446836, 8969.147930946567, 2222.9666555001686, 2487.589547724632, 2532.493501299743, 2563.628273900283, 2569.1264969910226, 2575.047232523969, 2591.2485379239997, 2597.1169802267227, 2597.2857464197405, 2597.714251432341, 2182.3125715399597, 2437.902483900642, 2458.360826185196, 2464.3346296499935, 2518.534071196825, 2511.748825117492, 2554.782843458299, 2559.5520783862844, 2564.910228142006, 2570.961435578468, 2521.357053951249, 2551.553478141318, 2560.308716646495, 2566.691996960358, 2570.5244529762053, 9178.541072946326, 9236.214921731593, 9237.722868313962, 9246.260299176118, 9264.305177111744, 5547.25112109868, 5719.7140142992685, 5754.482096611283, 5758.049921762904, 5761.423857614247, 3579.928401431983, 3648.8175591220597, 3685.539307586552, 3688.79711615861, 3717.9070523236865, 1059.099765199582, 1073.688630297213, 1073.7852429514128, 1087.7117563845586, 1106.9557217711363, 12593.496260149583, 12628.179168354027, 12629.621111366674, 12631.178973366701, 12645.367731613474, 4556.407667003268, 4638.97680511602, 4919.3604831371695, 4981.701097934136, 5058.696478211245, 10588.894111058946, 10602.787944241227, 10606.416647084485, 10621.734456638645, 10632.096271816827, 5650.434956504317, 5665.065264231438, 5667.574931880125, 5675.0636145035605, 5678.5741069419955, 4539.364488971547, 4691.225947718656, 4906.239532872411, 5087.0, 5146.0, 3387.5765529308837, 4039.2123535910805, 4093.2222877653153, 4151.958480415217, 4194.937075943863, 1331.7669407853587, 1338.718869037513, 1348.5166317051362, 1352.4657760184673, 1358.7893876449166, 1376.8141300924447, 1399.7340505304164, 1405.4659229492931, 1408.3028900694221, 1433.985660143406, 8577.699780507652, 8638.78403039929, 8654.307655387554, 8690.217880390795, 8710.956445217733, 513.6045245161205, 522.3601088666429, 527.4830665947393, 527.517321650693, 528.6880740363205, 6339.492840572743, 6345.397187267295, 6396.744130234739, 6409.935900640934, 6410.903836442457, 11033.337999720043, 11599.420028998516, 11608.593699220655, 11613.419329033515, 11614.954654081173, 11040.723981900517, 11258.38078905668, 11300.434978251054, 11366.033887119687, 11437.313761174357, 8754.47473151613, 8761.38670293086, 8772.824543509221, 8852.3803333766, 8858.955705221562, 8190.0, 8246.628901699318, 8280.130586288353, 8322.833543328978, 8335.916640833513, 9999.100080992746, 10118.8482172766, 10169.288149829441, 10243.743906402102, 10331.535080921227, 10362.585496580052, 10524.263301568817, 10551.0, 10646.414447205478, 10750.784984300426, 6981.0, 7154.069970903749, 7545.471816972759, 7831.530108193527, 8354.58227088631, 8635.913640863511, 8651.48091114535, 8703.91296087031, 8717.956410217908, 8720.65117395297, 7494.063242094739, 7688.308052275322, 7707.92292077072, 7760.223977602194, 7866.449348545547, 7462.141853686896, 7464.141623713343, 7544.245575442412, 7578.242175782378, 7700.8459830804195, 6768.526203165731, 8194.713185038496, 8201.95899020501, 8209.0, 8223.383246256675, 7196.604186769778, 7364.447666425147, 7367.889481657672, 7398.926010739824, 7410.407167426485, 7498.175200728025, 7507.211742766931, 7535.434842386733, 7536.3970882328185, 7545.622718863925], "unit": "score", "name": "mootools.html", "value": 5043.421409590218}, {"lowerIsBetter": false, "replicates": [315.7048159970428, 324.380433372259, 328.67297039445754, 334.54835971438547, 337.783818356252, 6470.482361411082, 6540.672966351682, 6560.86878262435, 6623.2052153741615, 6662.300458451866, 6501.317361677026, 6533.869322613545, 6537.21553413591, 6545.672716364186, 6563.310852360493, 3773.207626398446, 4691.88270293242, 4747.216709242971, 4854.635902307315, 4856.3201151838775, 4835.371401717772, 4844.32179494871, 4846.806127754903, 4847.175980083394, 4885.682430642015, 4825.493323201066, 4850.539198776129, 4854.902901941959, 4857.781399837016, 4863.221884498481, 4607.032523170138, 4695.248760198352, 4779.972305954202, 4790.760461976922, 4817.927731084036, 4104.835806567734, 4108.322126849066, 4117.938230926538, 4120.7321524101135, 4123.835046598132, 6284.528660350446, 6340.270868850095, 6350.491960643138, 6355.618662880196, 6360.586561873463, 5757.798477053325, 5760.884782304331, 5778.335491418498, 5792.913106303409, 5797.88404231913, 6786.117804685359, 7035.366816986445, 7045.330693584153, 7048.18945821232, 7048.541844780073, 3885.9222815543812, 4695.530446955311, 4720.386349774507, 4722.456917454502, 4727.361806156159, 6039.9396006039815, 7394.852102957911, 7460.0674915635545, 7460.701571937116, 7464.589447580381, 4136.86236285024, 4711.387519622427, 4809.206480930678, 4817.686850354716, 4830.806767729322, 4865.245886887538, 4874.341963834908, 4882.658213925062, 4884.1941079722155, 4894.926576101361, 5767.711614419262, 5782.7686892523825, 5782.913256301159, 5794.739236734357, 5800.419958004166, 6768.661566921733, 7081.150261968493, 7085.078939737904, 7094.68073936674, 7095.787126386217, 1404.761190597601, 1652.239969613967, 1672.6654669066236, 1686.4350442601622, 1686.7554204640257, 1033.452270296744, 1056.9048785609332, 1085.1535802074395, 1093.5243169221415, 1112.4660163121746, 6495.610263384212, 6606.0, 6629.602223866584, 6633.568818026813, 6634.734610615618, 7358.632068396559, 7375.11498620169, 7385.224551422023, 7387.889181662279, 7394.445416593777, 6656.966715166393, 6668.333166683293, 6672.633005184762, 6673.132492776005, 6688.230853451818, 3772.5850156482766, 3829.4064420014943, 3888.494495715539, 3892.630200130983, 3896.7077469189926, 6025.855087533355, 6710.899336509956, 7387.556746595222, 7644.847103057908, 7743.4966727162555, 7520.0, 7610.391168706601, 7611.847763044819, 7618.352440042548, 7630.8855367169535, 7685.42359323053, 7695.6152192390155, 7728.033995750531, 7732.381409487228, 7732.6133693315105, 7125.465590080868, 7351.338379545867, 7352.632368381666, 7361.779146625609, 7362.6686799093095, 7239.384652304402, 7276.199618042117, 7276.818079548054, 7295.927040729524, 7308.123025237006, 7767.650455729618, 7770.494917830323, 7773.572453515111, 7779.494332868572, 7781.471021918012, 4014.7189696720948, 4597.862064138081, 4607.792649330721, 4643.8374656886845, 4654.534546545318, 7054.153501579844, 7349.30181632744, 7361.1166659999, 7361.852762944604, 7364.521306115085, 7021.438284937295, 7042.471814613822, 7072.398846098139, 7076.7523136692025, 7100.0414943981905, 7075.5047146699235, 7092.326229008236, 7095.503314767917, 7108.893366599402, 7111.395531379684, 6937.791866244021, 6940.6182659952165, 6948.305169483214, 6951.9304806953305, 6956.40870526011, 6863.245043045361, 7043.330883566053, 7079.823004424725, 7098.112735908012, 7108.395786358217, 6558.376954189344, 6709.966450167718, 6833.145856767904, 6888.827779305558, 6953.0], "unit": "score", "name": "prototype.html", "value": 5166.370784650725}, {"lowerIsBetter": false, "replicates": [709.5565271705184, 758.9127250366208, 769.3076231391743, 786.8386980668963, 794.3645083932852, 14914.179720115402, 15215.923920380383, 15229.543113706593, 15231.933764636466, 15242.314095865684, 14311.35598898052, 14507.347169377377, 14521.49174778883, 14529.636759081028, 14544.854551454482, 794.4637369775407, 798.3054742374143, 951.6621599332224, 982.4203719805314, 986.378581493658, 888.5823662878469, 944.9574769135405, 945.2390825385562, 946.7822400847809, 961.048561923694, 1003.4481035430521, 1003.9397636141819, 1004.2267454060369, 1006.9194464442863, 1033.5349092908184, 821.3100995164091, 825.2160447574768, 830.8504469195542, 993.8757655293089, 1028.9691309260697, 617.8053913017385, 752.3868047541291, 753.8266198774257, 758.8140905478193, 759.8062494064034, 15239.542813715607, 15282.235888205656, 15307.923460382739, 15312.464063757716, 15348.92557520974, 12690.936545317214, 12958.676033099247, 13006.804897926539, 13246.73506529864, 13256.86743132566, 9990.486673872263, 10049.69850904474, 10142.340747851365, 10414.895851041469, 10470.110040646554, 3441.174118211611, 3487.9302413951577, 3530.858765649371, 3580.7672501287593, 3738.5700644425965, 75429.62285188539, 79407.0, 81624.9999999994, 82637.17362826355, 82882.58558707168, 9485.525723713787, 9773.46245956465, 9821.852672209923, 9914.40513569188, 9983.251256155818, 21364.824934628436, 21385.0, 21405.35783926485, 21416.78583214179, 21462.785372146078, 7470.0662417197855, 7559.357454616419, 7619.276168763959, 7696.345810606162, 7908.446408751447, 4056.148208876169, 4117.3618089196225, 4134.524529679125, 4220.831166753357, 4381.846635367747, 3747.1194269346684, 3781.773093614392, 3792.393217085253, 3793.886183414502, 3797.981010094987, 660.6465540935576, 676.3540818518303, 677.7424578660176, 683.9145106861642, 685.1333063674456, 599.7690889007763, 602.4096385542193, 617.9567430279927, 623.3579413204407, 627.6807197405543, 7243.840985442409, 8258.504489730636, 8300.501969881827, 8388.622511986854, 8454.915450845536, 563.391537139888, 610.8875280446119, 613.1171113596407, 617.9104029915727, 630.8769789891019, 3816.4275358695863, 3919.862804801818, 3996.2207369562657, 3999.7400168988925, 4019.638232559084, 79776.0, 87245.0, 90527.0, 92687.0, 92986.53506732424, 76440.0, 77518.0, 78215.0, 78545.0, 80343.59828200821, 56023.719881400335, 61662.69168654218, 69103.65448172827, 70100.0, 70312.0, 7794.493357931717, 7899.84200316002, 8064.55644939534, 8093.35253179756, 8101.554414507259, 48114.75942620265, 48291.27563086486, 49637.25544116769, 49918.0, 50284.0, 65887.67056164688, 72640.0, 73235.63382183055, 73450.26549734434, 74854.0, 11237.662870113909, 11249.268797528135, 11273.436328183394, 11436.542538298374, 11736.70658233551, 11924.940375298069, 11983.700407489883, 12248.142630015813, 12267.693307667023, 12995.350232488527, 11725.472353744273, 11909.52361905514, 11945.223560468541, 12216.144869859025, 12295.385230738248, 11768.94115529417, 11816.527338906348, 11887.227330223508, 12132.575359862363, 12195.817062743889, 9757.463339516395, 11383.886161138282, 11542.13433992437, 11903.0, 11988.280703157838, 8709.824173736464, 9615.855762163434, 9745.366551174151, 9922.702318930154, 9973.650922217688, 9640.662576809778, 9913.405195688281, 9934.602615895283, 9959.203263739028, 9971.05274998903], "unit": "score", "name": "yui.html", "value": 7033.741125376576}], "name": "dromaeo_css", "value": 7618.163959559094}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 110.0, 136.0, 158.0, 162.0, 121.0, 110.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 124.1}, {"lowerIsBetter": true, "replicates": [151.0, 119.0, 152.0, 144.0, 115.0, 136.0, 116.0, 149.0, 148.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 134.7}, {"lowerIsBetter": true, "replicates": [187.0, 186.0, 198.0, 261.0, 207.0, 185.0, 185.0, 186.0, 185.0, 185.0], "unit": "score", "name": "audio-dft", "value": 196.5}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 75.0, 120.0, 60.0, 83.0, 46.0, 54.0, 128.0, 55.0], "unit": "score", "name": "audio-fft", "value": 77.0}, {"lowerIsBetter": true, "replicates": [90.0, 95.0, 127.0, 77.0, 81.0, 87.0, 117.0, 76.0, 77.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 94.6}, {"lowerIsBetter": true, "replicates": [87.0, 83.0, 87.0, 84.0, 86.0, 83.0, 88.0, 84.0, 86.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.4}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 94.0, 93.0, 93.0, 93.0, 93.0, 94.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.2}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 96.0, 116.0, 86.0, 87.0, 94.0, 86.0, 85.0, 88.0], "unit": "score", "name": "imaging-desaturate", "value": 91.1}, {"lowerIsBetter": true, "replicates": [53.0, 58.0, 57.0, 57.0, 57.0, 58.0, 58.0, 68.0, 51.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [61.0, 62.0, 68.0, 66.0, 78.0, 72.0, 66.0, 64.0, 65.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.9}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 81.0, 80.0, 82.0, 83.0, 97.0, 104.0, 81.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [134.0, 127.0, 123.0, 133.0, 129.0, 119.0, 132.0, 113.0, 122.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.2}, {"lowerIsBetter": true, "replicates": [132.0, 121.0, 117.0, 134.0, 161.0, 149.0, 176.0, 154.0, 132.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.0}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 65.0, 66.0, 66.0, 66.0, 64.0, 61.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.2}], "name": "kraken", "value": 1438.3000000000002}]} 15:16:00 INFO - Return code: 0 15:16:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:16:00 INFO - # TBPL SUCCESS # 15:16:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:16:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:16:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:16:00 INFO - 2016-04-11 15:16:00.490 screenresolution[1675:9644] starting screenresolution argv=screenresolution get 15:16:00 INFO - 2016-04-11 15:16:00.492 screenresolution[1675:9644] Display 0: 1600x1200x32@60 15:16:00 INFO - 2016-04-11 15:16:00.498 screenresolution[1676:9647] starting screenresolution argv=screenresolution list 15:16:00 INFO - Available Modes on Display 0 15:16:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:16:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:16:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:16:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:16:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:16:00 INFO - Intel Iris: 15:16:00 INFO - Chipset Model: Intel Iris 15:16:00 INFO - Type: GPU 15:16:00 INFO - Bus: Built-In 15:16:00 INFO - VRAM (Dynamic, Max): 1536 MB 15:16:00 INFO - Vendor: Intel (0x8086) 15:16:00 INFO - Device ID: 0x0a2e 15:16:00 INFO - Revision ID: 0x0009 15:16:00 INFO - Displays: 15:16:00 INFO - Display: 15:16:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:16:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:16:00 INFO - Display Serial Number: 1600x1200 60 15:16:00 INFO - Main Display: Yes 15:16:00 INFO - Mirror: Off 15:16:00 INFO - Online: Yes 15:16:00 INFO - Rotation: Supported 15:16:00 INFO - Return code: 0 15:16:00 INFO - Running post-action listener: _resource_record_post_action 15:16:00 INFO - Running post-run listener: _resource_record_post_run 15:16:01 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 37557760; Write bytes: 663838720; Read time: 472; Write time: 1920 15:16:01 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 363774464; Write bytes: 353519616; Read time: 27980; Write time: 647 15:16:01 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 30404096; Write bytes: 299145216; Read time: 382; Write time: 1244 15:16:01 INFO - Running post-run listener: _upload_blobber_files 15:16:01 INFO - Blob upload gear active. 15:16:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:16:01 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 15:16:01 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'] 15:16:01 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 15:16:02 INFO - (blobuploader) - INFO - Open directory for files ... 15:16:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:16:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:16:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:16:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:16:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:16:03 INFO - (blobuploader) - INFO - Done attempting. 15:16:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:16:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:16:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:16:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:16:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:16:04 INFO - (blobuploader) - INFO - Done attempting. 15:16:04 INFO - (blobuploader) - INFO - Iteration through files over. 15:16:04 INFO - Return code: 0 15:16:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:16:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:16:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc9639ac6675d83cabb8111ccc96db06f2d2b551d8a5d624d6b8490d6551015fd6a48510413bdfa426e6175a7b283ea44c020813e1d206a1c57fb0036dd7ee4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/713293eb4341fb4a4bed66ed8df6bc1f6223f116895d41c986eb9679b014bc84e4512b78fc00cd6cd0192cc3f751f909af2c79e4a64552eda965f83f8cbe0b9e"} 15:16:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:16:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:16:04 INFO - Contents: 15:16:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc9639ac6675d83cabb8111ccc96db06f2d2b551d8a5d624d6b8490d6551015fd6a48510413bdfa426e6175a7b283ea44c020813e1d206a1c57fb0036dd7ee4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/713293eb4341fb4a4bed66ed8df6bc1f6223f116895d41c986eb9679b014bc84e4512b78fc00cd6cd0192cc3f751f909af2c79e4a64552eda965f83f8cbe0b9e"} 15:16:04 INFO - Running post-run listener: copy_logs_to_upload_dir 15:16:04 INFO - Copying logs to upload dir... 15:16:04 INFO - mkdir: /builds/slave/test/build/upload/logs 15:16:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.722999 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-04-11 15:16:04.245720) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 15:16:04.250552) ========= 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.zLZ09SFyFy/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.vg7hV07chT/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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/dc9639ac6675d83cabb8111ccc96db06f2d2b551d8a5d624d6b8490d6551015fd6a48510413bdfa426e6175a7b283ea44c020813e1d206a1c57fb0036dd7ee4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/713293eb4341fb4a4bed66ed8df6bc1f6223f116895d41c986eb9679b014bc84e4512b78fc00cd6cd0192cc3f751f909af2c79e4a64552eda965f83f8cbe0b9e"} build_url:https://queue.taskcluster.net/v1/task/GYqG9k7pSTClgXnwTOANog/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011225 build_url: 'https://queue.taskcluster.net/v1/task/GYqG9k7pSTClgXnwTOANog/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/dc9639ac6675d83cabb8111ccc96db06f2d2b551d8a5d624d6b8490d6551015fd6a48510413bdfa426e6175a7b283ea44c020813e1d206a1c57fb0036dd7ee4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/713293eb4341fb4a4bed66ed8df6bc1f6223f116895d41c986eb9679b014bc84e4512b78fc00cd6cd0192cc3f751f909af2c79e4a64552eda965f83f8cbe0b9e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 15:16:04.280552) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 15:16:04.280838) ========= 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.zLZ09SFyFy/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.vg7hV07chT/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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.005211 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 15:16:04.330325) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 15:16:04.330610) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 15:16:04.331324) ========= ========= Total master_lag: 1.63 =========