builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0172 starttime: 1458035676.12 results: success (0) buildid: 20160315004019 builduid: 619bbd11c8f040cea25151d90770bf4e revision: 5e9097f4bf87974241e6c1673c4a5633d888f9ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 02:54:36.118613) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 02:54:36.119068) ========= ========= Started set props: basedir (results: 0, elapsed: 2 secs) (at 2016-03-15 02:54:36.119358) ========= 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.zH0CBgkELQ/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.3zhLlDnhVs/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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.005595 basedir: '/builds/slave/test' ========= master_lag: 2.61 ========= ========= Finished set props: basedir (results: 0, elapsed: 2 secs) (at 2016-03-15 02:54:38.734463) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 18 secs) (at 2016-03-15 02:54:38.734746) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 18 secs) (at 2016-03-15 02:54:56.888023) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 9 secs) (at 2016-03-15 02:54:56.888281) ========= 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.zH0CBgkELQ/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.3zhLlDnhVs/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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.005803 ========= master_lag: 9.26 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 9 secs) (at 2016-03-15 02:55:06.151624) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 02:55:06.151981) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 02:55:06.152345) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-15 02:55:06.152630) ========= 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.zH0CBgkELQ/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.3zhLlDnhVs/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-15 02:55:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.8M=0.001s 2016-03-15 02:55:06 (14.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174539 ========= master_lag: 2.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-15 02:55:08.381872) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-15 02:55:08.384999) ========= 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.zH0CBgkELQ/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.3zhLlDnhVs/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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.024592 ========= master_lag: 1.00 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-15 02:55:09.411676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-15 02:55:09.412074) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5e9097f4bf87974241e6c1673c4a5633d888f9ad --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5e9097f4bf87974241e6c1673c4a5633d888f9ad --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zH0CBgkELQ/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.3zhLlDnhVs/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-15 02:55:09,820 truncating revision to first 12 chars 2016-03-15 02:55:09,820 Setting DEBUG logging. 2016-03-15 02:55:09,820 attempt 1/10 2016-03-15 02:55:09,820 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5e9097f4bf87?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-15 02:55:10,473 unpacking tar archive at: mozilla-aurora-5e9097f4bf87/testing/mozharness/ program finished with exit code 0 elapsedTime=0.906031 ========= master_lag: 0.37 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-15 02:55:10.688121) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-03-15 02:55:10.688442) ========= echo 5e9097f4bf87974241e6c1673c4a5633d888f9ad in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5e9097f4bf87974241e6c1673c4a5633d888f9ad'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zH0CBgkELQ/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.3zhLlDnhVs/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 5e9097f4bf87974241e6c1673c4a5633d888f9ad program finished with exit code 0 elapsedTime=0.005605 script_repo_revision: '5e9097f4bf87974241e6c1673c4a5633d888f9ad' ========= master_lag: 1.13 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-03-15 02:55:11.825434) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 9 secs) (at 2016-03-15 02:55:11.825731) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 9 secs) (at 2016-03-15 02:55:21.338229) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-15 02:55:21.338531) ========= /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.zH0CBgkELQ/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.3zhLlDnhVs/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:55:21 INFO - MultiFileLogger online at 20160315 02:55:21 in /builds/slave/test 02:55:21 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 02:55:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:55:21 INFO - {'append_to_log': False, 02:55:21 INFO - 'base_work_dir': '/builds/slave/test', 02:55:21 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:55:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:55:21 INFO - 'branch': 'Mozilla-Aurora', 02:55:21 INFO - 'buildbot_json_path': 'buildprops.json', 02:55:21 INFO - 'config_files': ('talos/mac_config.py',), 02:55:21 INFO - 'default_actions': ('clobber', 02:55:21 INFO - 'read-buildbot-config', 02:55:21 INFO - 'download-and-extract', 02:55:21 INFO - 'populate-webroot', 02:55:21 INFO - 'create-virtualenv', 02:55:21 INFO - 'install', 02:55:21 INFO - 'run-tests'), 02:55:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:55:21 INFO - 'download_minidump_stackwalk': True, 02:55:21 INFO - 'download_symbols': 'ondemand', 02:55:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:55:21 INFO - 'tooltool.py': '/tools/tooltool.py', 02:55:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:55:21 INFO - '/tools/misc-python/virtualenv.py')}, 02:55:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:55:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:55:21 INFO - 'installer_path': 'installer.exe', 02:55:21 INFO - 'log_level': 'info', 02:55:21 INFO - 'log_name': 'talos', 02:55:21 INFO - 'log_to_console': True, 02:55:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:55:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:55:21 INFO - 'opt_config_files': (), 02:55:21 INFO - 'pip_index': False, 02:55:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:55:21 INFO - 'cmd': ('bash', 02:55:21 INFO - '-c', 02:55:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:55:21 INFO - 'enabled': True, 02:55:21 INFO - 'halt_on_failure': False, 02:55:21 INFO - 'name': 'check_screen_resolution'},), 02:55:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:55:21 INFO - 'cmd': ('bash', 02:55:21 INFO - '-c', 02:55:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:55:21 INFO - 'enabled': True, 02:55:21 INFO - 'halt_on_failure': False, 02:55:21 INFO - 'name': 'check_screen_resolution'},), 02:55:21 INFO - 'run_cmd_checks_enabled': True, 02:55:21 INFO - 'sps_profile': False, 02:55:21 INFO - 'sps_profile_interval': 0, 02:55:21 INFO - 'suite': 'dromaeojs', 02:55:21 INFO - 'system_bits': '32', 02:55:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:55:21 INFO - 'title': 't-yosemite-r7-0172', 02:55:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:55:21 INFO - 'use_talos_json': True, 02:55:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:55:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:55:21 INFO - 'work_dir': 'build'} 02:55:21 INFO - ##### 02:55:21 INFO - ##### Running clobber step. 02:55:21 INFO - ##### 02:55:21 INFO - Running pre-action listener: _resource_record_pre_action 02:55:21 INFO - Running main action method: clobber 02:55:21 INFO - rmtree: /builds/slave/test/build 02:55:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:55:23 INFO - Running post-action listener: _resource_record_post_action 02:55:23 INFO - ##### 02:55:23 INFO - ##### Running read-buildbot-config step. 02:55:23 INFO - ##### 02:55:23 INFO - Running pre-action listener: _resource_record_pre_action 02:55:23 INFO - Running main action method: read_buildbot_config 02:55:23 INFO - Using buildbot properties: 02:55:23 INFO - { 02:55:23 INFO - "project": "", 02:55:23 INFO - "product": "firefox", 02:55:23 INFO - "script_repo_revision": "production", 02:55:23 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:55:23 INFO - "repository": "", 02:55:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:55:23 INFO - "buildid": "20160315004019", 02:55:23 INFO - "stage_platform": "macosx64", 02:55:23 INFO - "basedir": "/builds/slave/test", 02:55:23 INFO - "nightly_build": "True", 02:55:23 INFO - "buildnumber": 219, 02:55:23 INFO - "slavename": "t-yosemite-r7-0172", 02:55:23 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:55:23 INFO - "platform": "yosemite_r7", 02:55:23 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:55:23 INFO - "branch": "mozilla-aurora", 02:55:23 INFO - "repo_path": "releases/mozilla-aurora", 02:55:23 INFO - "revision": "5e9097f4bf87974241e6c1673c4a5633d888f9ad", 02:55:23 INFO - "pgo_build": "False", 02:55:23 INFO - "builduid": "619bbd11c8f040cea25151d90770bf4e", 02:55:23 INFO - "slavebuilddir": "test" 02:55:23 INFO - } 02:55:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 02:55:23 INFO - Running post-action listener: _resource_record_post_action 02:55:23 INFO - ##### 02:55:23 INFO - ##### Running download-and-extract step. 02:55:23 INFO - ##### 02:55:23 INFO - Running pre-action listener: _resource_record_pre_action 02:55:23 INFO - Running main action method: download_and_extract 02:55:23 INFO - mkdir: /builds/slave/test/build/tests 02: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')]} 02:55:23 INFO - https://queue.taskcluster.net/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:55:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:55:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:55:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 02:55:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 02:55:24 INFO - Downloaded 1277 bytes. 02:55:24 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 02:55:24 INFO - Using the following test package requirements: 02:55:24 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:55:24 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:55:24 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 02:55:24 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:55:24 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 02:55:24 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:55:24 INFO - u'jsshell-mac.zip'], 02:55:24 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:55:24 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 02:55:24 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:55:24 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:55:24 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 02:55:24 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:55:24 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 02:55:24 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:55:24 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 02:55:24 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:55:24 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:55:24 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 02:55:24 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:24 INFO - https://queue.taskcluster.net/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:55:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:55:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:55:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:55:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:55:26 INFO - Downloaded 17865145 bytes. 02:55:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:55:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:55:29 INFO - Return code: 0 02:55:29 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:55:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:29 INFO - https://queue.taskcluster.net/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:55:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:55:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:55:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:55:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:55:30 INFO - Downloaded 17865145 bytes. 02:55:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:55:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:55:33 INFO - Return code: 0 02:55:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:33 INFO - https://queue.taskcluster.net/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:55:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:55:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:55:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:55:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:55:35 INFO - Downloaded 10845161 bytes. 02:55:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:55:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 02:55:35 INFO - Return code: 0 02:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:35 INFO - https://queue.taskcluster.net/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:55:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:55:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:55:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 02:55:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 02:55:38 INFO - Downloaded 115151899 bytes. 02:55:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:55:38 INFO - mkdir: /builds/slave/test/properties 02:55:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:55:38 INFO - Writing to file /builds/slave/test/properties/build_url 02:55:38 INFO - Contents: 02:55:38 INFO - build_url:https://queue.taskcluster.net/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:55:39 INFO - Running post-action listener: _resource_record_post_action 02:55:39 INFO - Running post-action listener: set_extra_try_arguments 02:55:39 INFO - ##### 02:55:39 INFO - ##### Running populate-webroot step. 02:55:39 INFO - ##### 02:55:39 INFO - Running pre-action listener: _resource_record_pre_action 02:55:39 INFO - Running main action method: populate_webroot 02:55:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:55:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:55:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:55:39 INFO - '--tppagecycles', 02:55:39 INFO - '7'], 02:55:39 INFO - 'tests': ['tsvgm']}}, 02:55:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:55:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:55:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:55:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:55:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:55:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:55:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:55:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:39 INFO - 'talos_options': ['--e10s'], 02:55:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:55:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:39 INFO - 'tests': ['damp', 'tps']}, 02:55:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:39 INFO - 'talos_options': ['--e10s'], 02:55:39 INFO - 'tests': ['damp', 'tps']}, 02:55:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:55:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:55:39 INFO - 'other': {'tests': ['a11yr', 02:55:39 INFO - 'ts_paint', 02:55:39 INFO - 'tpaint', 02:55:39 INFO - 'sessionrestore', 02:55:39 INFO - 'sessionrestore_no_auto_restore', 02:55:39 INFO - 'tabpaint']}, 02:55:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:55:39 INFO - 'tests': ['a11yr', 02:55:39 INFO - 'ts_paint', 02:55:39 INFO - 'tpaint', 02:55:39 INFO - 'sessionrestore', 02:55:39 INFO - 'sessionrestore_no_auto_restore', 02:55:39 INFO - 'tabpaint']}, 02:55:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:55:39 INFO - 'tests': ['a11yr', 02:55:39 INFO - 'ts_paint', 02:55:39 INFO - 'tpaint', 02:55:39 INFO - 'sessionrestore', 02:55:39 INFO - 'sessionrestore_no_auto_restore', 02:55:39 INFO - 'tabpaint']}, 02:55:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:55:39 INFO - 'tests': ['a11yr', 02:55:39 INFO - 'ts_paint', 02:55:39 INFO - 'tpaint', 02:55:39 INFO - 'sessionrestore', 02:55:39 INFO - 'sessionrestore_no_auto_restore', 02:55:39 INFO - 'tabpaint']}, 02:55:39 INFO - 'other_l64': {'tests': ['a11yr', 02:55:39 INFO - 'ts_paint', 02:55:39 INFO - 'tpaint', 02:55:39 INFO - 'sessionrestore', 02:55:39 INFO - 'sessionrestore_no_auto_restore', 02:55:39 INFO - 'tabpaint']}, 02:55:39 INFO - 'other_nol64': {'tests': ['a11yr', 02:55:39 INFO - 'ts_paint', 02:55:39 INFO - 'tpaint', 02:55:39 INFO - 'sessionrestore', 02:55:39 INFO - 'sessionrestore_no_auto_restore', 02:55:39 INFO - 'tabpaint']}, 02:55:39 INFO - 'svgr': {'tests': ['tsvgx', 02:55:39 INFO - 'tsvgr_opacity', 02:55:39 INFO - 'tart', 02:55:39 INFO - 'tscrollx', 02:55:39 INFO - 'cart']}, 02:55:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:55:39 INFO - 'tests': ['tsvgx', 02:55:39 INFO - 'tsvgr_opacity', 02:55:39 INFO - 'tart', 02:55:39 INFO - 'tscrollx', 02:55:39 INFO - 'cart']}, 02:55:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:39 INFO - 'tests': ['tp5o']}, 02:55:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:39 INFO - 'talos_options': ['--e10s'], 02:55:39 INFO - 'tests': ['tp5o']}, 02:55:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:39 INFO - 'talos_options': ['--xperf_path', 02:55:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:55:39 INFO - 'tests': ['tp5n']}, 02:55:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:39 INFO - 'talos_options': ['--e10s', 02:55:39 INFO - '--xperf_path', 02:55:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:55:39 INFO - 'tests': ['tp5n']}}, 02:55:39 INFO - 'talos.zip': {'path': '', 02:55:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:55:39 INFO - Running post-action listener: _resource_record_post_action 02:55:39 INFO - ##### 02:55:39 INFO - ##### Running create-virtualenv step. 02:55:39 INFO - ##### 02:55:39 INFO - Running pre-action listener: _resource_record_pre_action 02:55:39 INFO - Running main action method: create_virtualenv 02:55:39 INFO - Creating virtualenv /builds/slave/test/build/venv 02:55:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:55:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:55:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:55:39 INFO - Using real prefix '/tools/python27' 02:55:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:55:40 INFO - Installing distribute.............................................................................................................................................................................................done. 02:55:42 INFO - Installing pip.................done. 02:55:42 INFO - Return code: 0 02:55:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:42 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 0x108f23a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f2a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64ad9d2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dc7d30>, '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 0x108c2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dbeb20>, '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.zH0CBgkELQ/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.3zhLlDnhVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:55:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:55:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zH0CBgkELQ/Render', 02:55:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:42 INFO - 'HOME': '/Users/cltbld', 02:55:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:42 INFO - 'LOGNAME': 'cltbld', 02:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:42 INFO - 'MOZ_NO_REMOTE': '1', 02:55:42 INFO - 'NO_EM_RESTART': '1', 02:55:42 INFO - 'PAGER': '/bin/cat', 02:55:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:42 INFO - 'PWD': '/builds/slave/test', 02:55:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:42 INFO - 'SHELL': '/bin/bash', 02:55:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3zhLlDnhVs/Listeners', 02:55:42 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 02:55:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:42 INFO - 'USER': 'cltbld', 02:55:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:42 INFO - 'XPC_FLAGS': '0x0', 02:55:42 INFO - 'XPC_SERVICE_NAME': '0', 02:55:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:55:43 INFO - Cleaning up... 02:55:43 INFO - Return code: 0 02:55:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:43 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 0x108f23a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f2a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64ad9d2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dc7d30>, '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 0x108c2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dbeb20>, '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.zH0CBgkELQ/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.3zhLlDnhVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:55:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:55:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zH0CBgkELQ/Render', 02:55:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:43 INFO - 'HOME': '/Users/cltbld', 02:55:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:43 INFO - 'LOGNAME': 'cltbld', 02:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:43 INFO - 'MOZ_NO_REMOTE': '1', 02:55:43 INFO - 'NO_EM_RESTART': '1', 02:55:43 INFO - 'PAGER': '/bin/cat', 02:55:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:43 INFO - 'PWD': '/builds/slave/test', 02:55:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:43 INFO - 'SHELL': '/bin/bash', 02:55:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3zhLlDnhVs/Listeners', 02:55:43 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 02:55:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:43 INFO - 'USER': 'cltbld', 02:55:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:43 INFO - 'XPC_FLAGS': '0x0', 02:55:43 INFO - 'XPC_SERVICE_NAME': '0', 02:55:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:43 INFO - Downloading/unpacking psutil>=0.7.1 02:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:55:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:55:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:55:46 INFO - Installing collected packages: psutil 02:55:46 INFO - Running setup.py install for psutil 02:55:47 INFO - building 'psutil._psutil_osx' extension 02:55:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:55:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:55:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:55:47 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:55:47 INFO - building 'psutil._psutil_posix' extension 02:55:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:55:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:55:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:55:47 INFO - ^ 02:55:47 INFO - 1 warning generated. 02:55:47 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:55:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:55:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:55:48 INFO - Successfully installed psutil 02:55:48 INFO - Cleaning up... 02:55:48 INFO - Return code: 0 02:55:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:48 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 0x108f23a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f2a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64ad9d2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dc7d30>, '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 0x108c2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dbeb20>, '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.zH0CBgkELQ/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.3zhLlDnhVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:55:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:55:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zH0CBgkELQ/Render', 02:55:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:48 INFO - 'HOME': '/Users/cltbld', 02:55:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:48 INFO - 'LOGNAME': 'cltbld', 02:55:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:48 INFO - 'MOZ_NO_REMOTE': '1', 02:55:48 INFO - 'NO_EM_RESTART': '1', 02:55:48 INFO - 'PAGER': '/bin/cat', 02:55:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:48 INFO - 'PWD': '/builds/slave/test', 02:55:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:48 INFO - 'SHELL': '/bin/bash', 02:55:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3zhLlDnhVs/Listeners', 02:55:48 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 02:55:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:48 INFO - 'USER': 'cltbld', 02:55:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:48 INFO - 'XPC_FLAGS': '0x0', 02:55:48 INFO - 'XPC_SERVICE_NAME': '0', 02:55:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02: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 02: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 02: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 02: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 02: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 02: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 02:55:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:55:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:55:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:55:50 INFO - Installing collected packages: mozsystemmonitor 02:55:50 INFO - Running setup.py install for mozsystemmonitor 02:55:50 INFO - Successfully installed mozsystemmonitor 02:55:50 INFO - Cleaning up... 02:55:51 INFO - Return code: 0 02:55:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:55: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')]} 02:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55: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')]} 02:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108f23a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f2a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64ad9d2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dc7d30>, '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 0x108c2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dbeb20>, '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.zH0CBgkELQ/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.3zhLlDnhVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:55:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:55:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zH0CBgkELQ/Render', 02:55:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:51 INFO - 'HOME': '/Users/cltbld', 02:55:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:51 INFO - 'LOGNAME': 'cltbld', 02:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:51 INFO - 'MOZ_NO_REMOTE': '1', 02:55:51 INFO - 'NO_EM_RESTART': '1', 02:55:51 INFO - 'PAGER': '/bin/cat', 02:55:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:51 INFO - 'PWD': '/builds/slave/test', 02:55:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:51 INFO - 'SHELL': '/bin/bash', 02:55:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3zhLlDnhVs/Listeners', 02:55:51 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 02:55:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:51 INFO - 'USER': 'cltbld', 02:55:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:51 INFO - 'XPC_FLAGS': '0x0', 02:55:51 INFO - 'XPC_SERVICE_NAME': '0', 02:55:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:51 INFO - Downloading/unpacking blobuploader==1.2.4 02:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:53 INFO - Downloading blobuploader-1.2.4.tar.gz 02:55:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:55:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02: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 02: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 02: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 02: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 02: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 02: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 02:55:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:55:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02: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 02: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 02: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 02: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 02: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 02: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 02:55:54 INFO - Downloading docopt-0.6.1.tar.gz 02:55:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:55:54 INFO - Installing collected packages: blobuploader, requests, docopt 02:55:54 INFO - Running setup.py install for blobuploader 02:55:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:55:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:55:55 INFO - Running setup.py install for requests 02:55:55 INFO - Running setup.py install for docopt 02:55:55 INFO - Successfully installed blobuploader requests docopt 02:55:55 INFO - Cleaning up... 02:55:55 INFO - Return code: 0 02:55:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:55 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 0x108f23a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f2a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64ad9d2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dc7d30>, '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 0x108c2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dbeb20>, '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.zH0CBgkELQ/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.3zhLlDnhVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:55:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zH0CBgkELQ/Render', 02:55:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:55 INFO - 'HOME': '/Users/cltbld', 02:55:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:55 INFO - 'LOGNAME': 'cltbld', 02:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:55 INFO - 'MOZ_NO_REMOTE': '1', 02:55:55 INFO - 'NO_EM_RESTART': '1', 02:55:55 INFO - 'PAGER': '/bin/cat', 02:55:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:55 INFO - 'PWD': '/builds/slave/test', 02:55:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:55 INFO - 'SHELL': '/bin/bash', 02:55:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3zhLlDnhVs/Listeners', 02:55:55 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 02:55:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:55 INFO - 'USER': 'cltbld', 02:55:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:55 INFO - 'XPC_FLAGS': '0x0', 02:55:55 INFO - 'XPC_SERVICE_NAME': '0', 02:55:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:55:56 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-CpC0vQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:55:56 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-7GewFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:55:56 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-51BofZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:55:56 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-YYFnrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:55:56 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-oLa43o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:55:56 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-88dofu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:55:56 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-1S_F81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:55:56 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-1pmxbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:55:56 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-1rVAAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:55:56 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-2jHTU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:55:57 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-Kjow2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:55:57 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-b5dmUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:55:57 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-GmBu_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:55:57 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-vkOJxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:55:57 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-mCPq6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:55:57 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-jKhaTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:55:57 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-WD3ttV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:55:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:55:57 INFO - Running setup.py install for manifestparser 02:55:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:55:57 INFO - Running setup.py install for mozcrash 02:55:58 INFO - Running setup.py install for mozdebug 02:55:58 INFO - Running setup.py install for mozdevice 02:55:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:55:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:55:58 INFO - Running setup.py install for mozfile 02:55:58 INFO - Running setup.py install for mozhttpd 02:55:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:55:58 INFO - Running setup.py install for mozinfo 02:55:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:55:58 INFO - Running setup.py install for mozInstall 02:55:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:55:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:55:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:55:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:55:58 INFO - Running setup.py install for mozleak 02:55:59 INFO - Running setup.py install for mozlog 02:55:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:55:59 INFO - Running setup.py install for moznetwork 02:55:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:55:59 INFO - Running setup.py install for mozprocess 02:55:59 INFO - Running setup.py install for mozprofile 02:55:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:55:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:55:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:55:59 INFO - Running setup.py install for mozrunner 02:55:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:55:59 INFO - Running setup.py install for mozscreenshot 02:56:00 INFO - Running setup.py install for moztest 02:56:00 INFO - Running setup.py install for mozversion 02:56:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:56:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:56:00 INFO - Cleaning up... 02:56:00 INFO - Return code: 0 02:56:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:00 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 0x108f23a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f2a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64ad9d2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dc7d30>, '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 0x108c2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dbeb20>, '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.zH0CBgkELQ/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.3zhLlDnhVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:56:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:56:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zH0CBgkELQ/Render', 02:56:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:00 INFO - 'HOME': '/Users/cltbld', 02:56:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:00 INFO - 'LOGNAME': 'cltbld', 02:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:00 INFO - 'MOZ_NO_REMOTE': '1', 02:56:00 INFO - 'NO_EM_RESTART': '1', 02:56:00 INFO - 'PAGER': '/bin/cat', 02:56:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:00 INFO - 'PWD': '/builds/slave/test', 02:56:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:00 INFO - 'SHELL': '/bin/bash', 02:56:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3zhLlDnhVs/Listeners', 02:56:00 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 02:56:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:00 INFO - 'USER': 'cltbld', 02:56:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:00 INFO - 'XPC_FLAGS': '0x0', 02:56:00 INFO - 'XPC_SERVICE_NAME': '0', 02:56:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:56:00 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-YihJGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:56:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:56:00 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-d3icZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:56:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:56:00 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-wH3NTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:56:01 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-vBnZc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:56:01 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-pDUUrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:56:01 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-69QAa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:56:01 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-Cx8R3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:56:01 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-RJ7cFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:56:01 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-V6FkS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:56:01 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-yfpD7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:56:01 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-JvhtXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:56:01 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-0TnuHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:56:01 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-RD_J8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:56:02 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-OaZxlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:02 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-tz3aEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:56:02 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-yvk2V_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:56:02 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-MSAfBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:56:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:04 INFO - Downloading blessings-1.6.tar.gz 02:56:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:56:04 INFO - Installing collected packages: blessings 02:56:04 INFO - Running setup.py install for blessings 02:56:05 INFO - Successfully installed blessings 02:56:05 INFO - Cleaning up... 02:56:05 INFO - Return code: 0 02:56:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:56:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:56:05 INFO - Reading from file tmpfile_stdout 02:56:05 INFO - Current package versions: 02:56:05 INFO - blessings == 1.6 02:56:05 INFO - blobuploader == 1.2.4 02:56:05 INFO - docopt == 0.6.1 02:56:05 INFO - manifestparser == 1.1 02:56:05 INFO - mozInstall == 1.12 02:56:05 INFO - mozcrash == 0.17 02:56:05 INFO - mozdebug == 0.1 02:56:05 INFO - mozdevice == 0.48 02:56:05 INFO - mozfile == 1.2 02:56:05 INFO - mozhttpd == 0.7 02:56:05 INFO - mozinfo == 0.9 02:56:05 INFO - mozleak == 0.1 02:56:05 INFO - mozlog == 3.1 02:56:05 INFO - moznetwork == 0.27 02:56:05 INFO - mozprocess == 0.22 02:56:05 INFO - mozprofile == 0.28 02:56:05 INFO - mozrunner == 6.11 02:56:05 INFO - mozscreenshot == 0.1 02:56:05 INFO - mozsystemmonitor == 0.0 02:56:05 INFO - moztest == 0.7 02:56:05 INFO - mozversion == 1.4 02:56:05 INFO - psutil == 3.1.1 02:56:05 INFO - requests == 1.2.3 02:56:05 INFO - wsgiref == 0.1.2 02:56:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:05 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 0x108f23a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f2a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64ad9d2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dc7d30>, '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 0x108c2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dbeb20>, '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.zH0CBgkELQ/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.3zhLlDnhVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:56:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:56:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zH0CBgkELQ/Render', 02:56:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:05 INFO - 'HOME': '/Users/cltbld', 02:56:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:05 INFO - 'LOGNAME': 'cltbld', 02:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:05 INFO - 'MOZ_NO_REMOTE': '1', 02:56:05 INFO - 'NO_EM_RESTART': '1', 02:56:05 INFO - 'PAGER': '/bin/cat', 02:56:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:05 INFO - 'PWD': '/builds/slave/test', 02:56:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:05 INFO - 'SHELL': '/bin/bash', 02:56:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3zhLlDnhVs/Listeners', 02:56:05 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 02:56:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:05 INFO - 'USER': 'cltbld', 02:56:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:05 INFO - 'XPC_FLAGS': '0x0', 02:56:05 INFO - 'XPC_SERVICE_NAME': '0', 02:56:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:56:05 INFO - Cleaning up... 02:56:05 INFO - Return code: 0 02:56:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:05 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 0x108f23a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f2a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64ad9d2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dc7d30>, '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 0x108c2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dbeb20>, '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.zH0CBgkELQ/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.3zhLlDnhVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:56:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:56:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zH0CBgkELQ/Render', 02:56:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:05 INFO - 'HOME': '/Users/cltbld', 02:56:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:05 INFO - 'LOGNAME': 'cltbld', 02:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:05 INFO - 'MOZ_NO_REMOTE': '1', 02:56:05 INFO - 'NO_EM_RESTART': '1', 02:56:05 INFO - 'PAGER': '/bin/cat', 02:56:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:05 INFO - 'PWD': '/builds/slave/test', 02:56:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:05 INFO - 'SHELL': '/bin/bash', 02:56:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3zhLlDnhVs/Listeners', 02:56:05 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 02:56:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:05 INFO - 'USER': 'cltbld', 02:56:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:05 INFO - 'XPC_FLAGS': '0x0', 02:56:05 INFO - 'XPC_SERVICE_NAME': '0', 02:56:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:05 INFO - Downloading/unpacking jsonschema 02:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:56:08 INFO - Downloading/unpacking functools32 (from jsonschema) 02:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:08 INFO - Downloading functools32-3.2.3-2.tar.gz 02:56:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:56:08 INFO - warning: no files found matching '*.txt' 02:56:08 INFO - no previously-included directories found matching 'build' 02:56:08 INFO - no previously-included directories found matching 'dist' 02:56:08 INFO - no previously-included directories found matching '.git*' 02:56:08 INFO - Installing collected packages: jsonschema, functools32 02:56:08 INFO - Running setup.py install for functools32 02:56:08 INFO - warning: no files found matching '*.txt' 02:56:08 INFO - no previously-included directories found matching 'build' 02:56:08 INFO - no previously-included directories found matching 'dist' 02:56:08 INFO - no previously-included directories found matching '.git*' 02:56:08 INFO - Successfully installed jsonschema functools32 02:56:08 INFO - Cleaning up... 02:56:09 INFO - Return code: 0 02:56:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:09 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 0x108f23a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f2a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64ad9d2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dc7d30>, '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 0x108c2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dbeb20>, '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.zH0CBgkELQ/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.3zhLlDnhVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:56:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:56:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zH0CBgkELQ/Render', 02:56:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:09 INFO - 'HOME': '/Users/cltbld', 02:56:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:09 INFO - 'LOGNAME': 'cltbld', 02:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:09 INFO - 'MOZ_NO_REMOTE': '1', 02:56:09 INFO - 'NO_EM_RESTART': '1', 02:56:09 INFO - 'PAGER': '/bin/cat', 02:56:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:09 INFO - 'PWD': '/builds/slave/test', 02:56:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:09 INFO - 'SHELL': '/bin/bash', 02:56:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3zhLlDnhVs/Listeners', 02:56:09 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 02:56:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:09 INFO - 'USER': 'cltbld', 02:56:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:09 INFO - 'XPC_FLAGS': '0x0', 02:56:09 INFO - 'XPC_SERVICE_NAME': '0', 02:56:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:09 INFO - Downloading/unpacking flake8 02:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:56:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:56:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:56:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:56:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:56:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:56:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:56:13 INFO - no previously-included directories found matching 'docs/_build' 02:56:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:56:13 INFO - Running setup.py install for pep8 02:56:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:56:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:56:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:56:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:56:13 INFO - no previously-included directories found matching 'docs/_build' 02:56:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:56:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:56:13 INFO - Cleaning up... 02:56:13 INFO - Return code: 0 02:56:13 INFO - Running post-action listener: _resource_record_post_action 02:56:13 INFO - Running post-action listener: _start_resource_monitoring 02:56:13 INFO - Starting resource monitoring. 02:56:13 INFO - ##### 02:56:13 INFO - ##### Running install step. 02:56:13 INFO - ##### 02:56:13 INFO - Running pre-action listener: _resource_record_pre_action 02:56:13 INFO - Running main action method: install 02:56:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:56:13 INFO - Reading from file tmpfile_stdout 02:56:13 INFO - Detecting whether we're running mozinstall >=1.0... 02:56:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:56:13 INFO - Reading from file tmpfile_stdout 02:56:13 INFO - Output received: 02:56:13 INFO - Usage: mozinstall [options] installer 02:56:13 INFO - Options: 02:56:13 INFO - -h, --help show this help message and exit 02:56:13 INFO - -d DEST, --destination=DEST 02:56:13 INFO - Directory to install application into. [default: 02:56:13 INFO - "/builds/slave/test"] 02:56:13 INFO - --app=APP Application being installed. [default: firefox] 02:56:13 INFO - mkdir: /builds/slave/test/build/application 02:56:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:56:45 INFO - Reading from file tmpfile_stdout 02:56:45 INFO - Output received: 02:56:45 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:56:45 INFO - Running post-action listener: _resource_record_post_action 02:56:45 INFO - ##### 02:56:45 INFO - ##### Running run-tests step. 02:56:45 INFO - ##### 02:56:45 INFO - Running pre-action listener: _resource_record_pre_action 02:56:45 INFO - Running main action method: run_tests 02:56:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:56:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:56:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:56:46 INFO - 2016-03-15 02:56:46.001 screenresolution[1645:7828] starting screenresolution argv=screenresolution get 02:56:46 INFO - 2016-03-15 02:56:46.003 screenresolution[1645:7828] Display 0: 1600x1200x32@60 02:56:46 INFO - 2016-03-15 02:56:46.009 screenresolution[1646:7830] starting screenresolution argv=screenresolution list 02:56:46 INFO - Available Modes on Display 0 02:56:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:56:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:56:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:56:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:56:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:56:46 INFO - Intel Iris: 02:56:46 INFO - Chipset Model: Intel Iris 02:56:46 INFO - Type: GPU 02:56:46 INFO - Bus: Built-In 02:56:46 INFO - VRAM (Dynamic, Max): 1536 MB 02:56:46 INFO - Vendor: Intel (0x8086) 02:56:46 INFO - Device ID: 0x0a2e 02:56:46 INFO - Revision ID: 0x0009 02:56:46 INFO - Displays: 02:56:46 INFO - Display: 02:56:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:56:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:56:46 INFO - Display Serial Number: 1600x1200 60 02:56:46 INFO - Main Display: Yes 02:56:46 INFO - Mirror: Off 02:56:46 INFO - Online: Yes 02:56:46 INFO - Rotation: Supported 02:56:46 INFO - Return code: 0 02:56:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:56:46 INFO - Python 2.7.3 02:56:46 INFO - Return code: 0 02:56:46 INFO - grabbing minidump binary from tooltool 02:56: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')]} 02:56:46 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 0x108dc7d30>, '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 0x108c2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dbeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:56:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:56:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:56:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:56:46 INFO - Return code: 0 02:56:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:56:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:56:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:56:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:56:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:56:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:56:47 INFO - Return code: 0 02:56:47 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/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0172', '--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 02:56:47 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/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0172 --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 02:56:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zH0CBgkELQ/Render', 02:56:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:47 INFO - 'HOME': '/Users/cltbld', 02:56:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:47 INFO - 'LOGNAME': 'cltbld', 02:56:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:56:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:47 INFO - 'MOZ_NO_REMOTE': '1', 02:56:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:56:47 INFO - 'NO_EM_RESTART': '1', 02:56:47 INFO - 'PAGER': '/bin/cat', 02:56:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:47 INFO - 'PWD': '/builds/slave/test', 02:56:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:56:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:47 INFO - 'SHELL': '/bin/bash', 02:56:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3zhLlDnhVs/Listeners', 02:56:47 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 02:56:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:47 INFO - 'USER': 'cltbld', 02:56:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:47 INFO - 'XPC_FLAGS': '0x0', 02:56:47 INFO - 'XPC_SERVICE_NAME': '0', 02:56:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:47 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/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0172', '--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 02:56:47 INFO - mozversion application_buildid: 20160315004019 02:56:47 INFO - mozversion application_changeset: 5e9097f4bf87974241e6c1673c4a5633d888f9ad 02:56:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:56:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:56:47 INFO - mozversion application_name: Firefox 02:56:47 INFO - mozversion application_remotingname: firefox-dev 02:56:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:56:47 INFO - mozversion application_vendor: Mozilla 02:56:47 INFO - mozversion application_version: 47.0a2 02:56:47 INFO - mozversion platform_buildid: 20160315004019 02:56:47 INFO - mozversion platform_changeset: 5e9097f4bf87974241e6c1673c4a5633d888f9ad 02:56:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:56:47 INFO - mozversion platform_version: 47.0a2 02:56:47 INFO - using testdate: 1458035807 02:56:47 INFO - actual date: 1458035807 02:56:47 INFO - starting webserver on 'localhost:49270' 02:56:47 INFO - SUITE-START | Running 2 tests 02:56:47 INFO - TEST-START | dromaeo_css 02:56:47 INFO - operating with platform_type : mac_ 02:56:47 INFO - Initialising browser for dromaeo_css test... 02:56:47 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmp3IfCxZ/profile http://localhost:49270/getInfo.html) 02:56:50 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 02:56:50 INFO - PROCESS | 1664 | colorDepth:24 02:56:50 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 02:56:50 INFO - PROCESS | 1664 | __metrics 02:56:50 INFO - PROCESS | 1664 | 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" 02:56:50 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:56:50 INFO - TEST-INFO | 1664: exit 0 02:56:50 INFO - Browser initialized. 02:56:50 INFO - Running cycle 1/1 for dromaeo_css test... 02:56:50 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmp3IfCxZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:57:02 INFO - PROCESS | 1668 | RSS: Main: 210694144 02:57:02 INFO - PROCESS | 1668 | 02:57:53 INFO - PROCESS | 1668 | 1458035873947 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] 03:00:04 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 03:00:05 INFO - PROCESS | 1668 | RSS: Main: 302772224 03:00:05 INFO - PROCESS | 1668 | 03:03:07 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 03:03:08 INFO - PROCESS | 1668 | RSS: Main: 345497600 03:03:08 INFO - PROCESS | 1668 | 03:06:10 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 03:06:11 INFO - PROCESS | 1668 | RSS: Main: 349085696 03:06:11 INFO - PROCESS | 1668 | 03:09:13 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 03:09:13 INFO - PROCESS | 1668 | RSS: Main: 306782208 03:09:13 INFO - PROCESS | 1668 | 03:12:16 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 03:12:17 INFO - PROCESS | 1668 | RSS: Main: 308551680 03:12:17 INFO - PROCESS | 1668 | 03:15:19 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 03:15:20 INFO - PROCESS | 1668 | RSS: Main: 354136064 03:15:20 INFO - PROCESS | 1668 | 03:15:20 INFO - PROCESS | 1668 | __start_tp_report 03:15:20 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 03:15:20 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 03:15:20 INFO - PROCESS | 1668 | |i|pagename|runs| 03:15:20 INFO - PROCESS | 1668 | |0;dojo.html;3450.84471198796;3515.1387909962064;3515.1563624730074;3526.506289119524;3578.8568457261713;5844.707764611774;5864.179014937912;5870.853228669285;5878.970605146974;5892.85267868303;5823.912641310373;5858.853528661785;5874.88250234995;5906.497947674442;5929.762809487626;5163.974180129094;5192.532672059505;5233.921491177635;5236.659617124875;5286.814961476349;5268.92096618551;5283.947160528403;5297.629165958385;5298.4436634153435;5298.92051619226;5270.4729527047375;5273.736313184345;5310.893782124355;5313.787448502056;5327.334083239595;5328.413874473805;5333.173358129496;5353.03645343838;5359.946400536003;5361.142217245222;5085.694858308476;5230;5279.524842764131;5285.841424757264;5288.338957630296;5680.659160450345;5774.740136693859;5777.855553611152;5782.045962416196;5802.419758024206;6123.4488895999575;6208.534359922979;6222.688865556749;6228.87542249157;6233.376662333776;6182.659953702545;6216.627002379872;6229.7508099676415;6255.030470277115;6307.653079080649;5961.910571341434;5969.970150149265;5970.850728731816;5972.581919265654;6020.036794112921;6238.313785483593;6282.937170628326;6323.873522529524;6368.5860419072615;6387.169667943138;6259.217597800275;6259.593126446766;6272.1219029335925;6280.685965701697;6291.339409362043;6292.716827742671;6294.685265736694;6301.7164227609865;6304.558680892385;6306.716197771111;6104.664243466652;6242.032484964838;6243.406876346739;6304.18045654062;6313.273973493016;6272.278687950853;6287.591306565058;6305.5901366411035;6310.116583678288;6320.55756097078;4966.329545511309;4971.130052240916;4976.576990955737;4977.029479251583;4994.650374473752;4389.034412429261;4419.447569053868;4466.39703640011;4487.192305384997;4531.864044078683;4813.350197723263;5741.45456181662;5753.367129615739;5765.221695071195;5789.45000224978;6240.032794916795;6258.749650013949;6280.1207830902795;6282.560220784501;6283.6858157091965;5588.972055139699;5601;5656.632318899258;5744.339400968858;5744.741486633112;5401;5408.810691625774;5409.810656626999;5410.675359478365;5415.214793854948;6400.0719895614875;6401.423871851555;6401.775937842153;6412.23053233615;6422.775202867877;6187.195664563578;6213.316535181217;6254.124422580933;6261.78083767066;6284.937150628435;5375.844193498417;6343.175387199819;6390.808275751735;6396.392342727433;6407.8718425630295;6234.9688251558455;6268.373162683695;6271.090691849748;6278.089676996901;6293.874122517615;6193.81418557444;6216.098665693358;6241.251049874044;6280.9685951569945;6312.179416675803;6017.939820601738;6045.365236650088;6119.502553941335;6206.06908963659;6235;5123.5644970177955;5190.8961820762615;5763.193152958673;6171.105189747551;6174.6912654368;4953.900921981468;5986.730597123053;6050.273967123973;6051.304100028553;6076.33160352352;6079.361667024898;6109.816705498843;6215.192025036717;6219.564630475823;6226.59527130735;6060.878692457604;6074.878502430015;6121.574916084878;6122.77432918503;6134.7059205304895 03:15:20 INFO - PROCESS | 1668 | |1;ext.html;470.17953670844383;563.7463141586287;589.8645108166778;630.0832289019477;645.3868824616615;26457.867710661445;32083.35833283336;39151.82544523665;39654;39757.40363894544;42669.35995960063;43261.13477730443;43341;43406.91482712934;43482.13035739283;9527.285453590992;9753.829540455155;9755.268354873377;9760.658376956808;9764.51177441125;9505.42967421957;9634.614615415376;9644.75888102796;9645.1801596864;9657;9733.707988760349;9734;9803.901960980405;9808.46053467059;9813.460259685715;9725.12473877351;9801.754956126048;9814.803703925882;9820;9853;9600.855987160197;9720.75698107546;9742.123208911233;9742.707718768377;9747.122758951728;41718;42094;42102.78948605268;42109;42220;3271.7055465008025;3365.7643964922463;3467.9133021674406;3563.376409128392;3827.5215598050245;26567.734322656914;27210.047648332213;27313.76524283672;27419.725802741916;27960;2739.260399692092;2756.8621568921476;2777.9722202777916;2792.9022484212956;2887.826730396183;495131;499322.0067799312;499671;500482;500597;46774.76612616983;47585;71392.64303678552;71701.64149179221;71981;48223;48239;48646.02707945821;48676;48772.51227487751;17027.829721702874;17150.742738858928;17170.055646939287;17170.141492925555;17183.656326873643;13592.728145437035;13626.182429054288;13662.795058074136;13678.31608419575;13680.973926955518;15188.860835437386;15229.695406092038;15243.466478673416;15266.770998435033;15317.157556334509;5907.763689452459;6058.969975104243;6524.054012168209;6661.933380666132;6713.56361836479;970.3256236915277;1024.6772266735954;1099.5491848342142;1099.771379047561;1102.2229328323513;29733.851330743208;29960;30242.54636180459;30625.387492250476;30850;1155.92486488378;1156.109795457493;1165.906727461801;1199.4602428907026;1267.689416093063;15329.923350383177;15387.846121538865;15501.612459688598;15736.213189340488;15749.291281892343;516881;519543;524810;527041;527996;60243;60866.391336086956;60893;61009;61037;1403.3053638449032;1420.1408148070475;1516.4313382481569;1532.6245069957931;1569.4506922577007;29146.27134321659;29420.411591768472;29515;30168.54747178838;30471.695283046887;39476.80261598674;48289;48448.788780280775;48559.02881942412;48815.511844882516;339540;340025.2998735089;341289;342828;342947;34298;44244.695371634196;44831;46619.30071048869;46648.53351466442;45244.86887827831;45459;45772.31341529946;46187.15251389907;46430;37747.81126094352;38088.61911380962;38100.61899380971;38125.80937095297;38712.41931370975;37353.0661733448;38120.42819357656;38229.23541529098;38854.222915540966;38962.6103738959;37867.62132378641;38297.23405531818;38620.227595448494;38669;38939.221215574966;32212;33572.83213583916;33966.98099057032;34013.14967125842;34107.48838767371;25442.236732898044;25622.231333060037;25630.615540767278;25799;25962.961481541282 03:15:20 INFO - PROCESS | 1668 | |2;jquery.html;384.66534115319666;386.0599440362717;388.0628282697288;394.81838354356995;397.1084914367246;16806.991580505146;17144.657106857856;19824.70262946057;21137.894310528445;21621.567568648636;17703.82296177038;17981.4605561833;19915.80084199161;20615.278465253683;22031.449213769665;5361.973190134064;5924.703764811753;6167.969160154215;6168.599041062339;6181.536384771138;4406.86779396617;5809.622374545662;5931.08068249422;6007.7596896124105;6078.513718902477;4588.082383523292;4596.839110631112;4600.700954437968;6309.810705678837;6579.506537009719;6333.113364129025;6557.672116394185;6562.081308616797;6564.146660934096;6604.966975165142;5751.597388182829;5798.130280457923;5805.129230615399;5806.361300256968;5806.941930580725;25408.745912540824;25944.351391215183;26417.603735943976;26441;26466;2231.141010710872;2333.8949747261413;2364.1961733010685;2368.585497537941;2411.8311718179734;14643.41426342945;15205.391784328614;15285.541433756895;15383.923080384639;15527.456539021194;1685.5280521454013;1785.276962830056;1799.703048996914;1816.5640246340915;1918.5779128591687;101553.49223253911;107955.46022269917;110288.34567481495;111839;113816;9429.575669094907;11023.393713345682;11411.771764564828;11844.70388240301;11952.88047119535;14078.929605351908;14104.012719109563;14165.362558684885;14200.928995355163;14249.358778854768;8822.691205807765;8882.911170888337;8883.511406872554;8892.15524525169;8958.507282099547;9014.909850901407;9018.954905225432;9020.368574199743;9079.81840363189;9092;4632.16621008215;4692.95307046932;4718.221493453541;4721.95278047222;4725.976370118127;1556.5563814312866;1923.8653294269266;1984.1567333883331;1986.1658103596524;2014.1943222711034;863.9049704532497;969.6703120938773;1001.329109496639;1068.2682362581656;1114.788190243851;16815.41146059882;20008.49978750543;21002;21152.894235528725;21182.258620948192;1011.8026984738052;1015.5582321690089;1030.314840630987;1063.4948399510172;1068.4016950507585;11164.609238676607;11479.540818367172;11495.597654082067;11498.655040348804;11698.2981021139;628150;634834;650025;682939;691110;119457;122024.38987805005;122336;123795;127755;911.2436677557612;1046.0951277145366;1054.4516851237313;1062.3201151263197;1063.3407287481657;18990.43028709141;19081.71377429312;19089.71365429492;19103.61792764109;19388.612227755082;50009.749951250014;51243.74378128086;53037.734811325696;53896.46103538915;55265;77572;77954.6102269485;78544;79030;80705.59647201726;8482.61828217744;8509.829803403773;8552.059273479788;8563.828723425371;8618.913810862063;9992.700218993441;11713.707157321136;13249.271290079138;13619.727605447637;14012;11262;11477.598284060017;11873.703157421134;11930.4034798258;12134.575289864812;9459.905400945903;11600.88399115998;11613.070954323464;11827.053835692952;11836.76326473483;11842.940785296018;11848.111391645489;11972.386784818711;12201.69495762613;12277.017838572714;8095.109537950939;8322.70870519529;8337.66337583453;8554.828903422022;8833.911660883308;8687.91312086871;11154.832677509681;11912.761744764883;12029.398530073637;12144.33206173669 03:15:20 INFO - PROCESS | 1668 | |3;mootools.html;1489.9404023839047;1525.0087443161935;1689.3833750681001;1980.6533856575095;2096.909607004358;8463.153684631534;9061.954690226548;9213.907860921388;9227;9234.907650923496;8899.065598112202;9159.313051521129;9161.725148245547;9161.946376166743;9169.128932751395;2238.3956331790487;2521.205820166651;2560.5775047117204;2589.2102908612865;2600;2578.2523068310165;2580.445204281079;2582.4705935283223;2582.6771653543306;2582.9225123246333;2436.6466862304956;2515.9874200629065;2520.823542352036;2521.6721826162666;2522.230719630521;2533.227365653484;2586.6508021417058;2596.195179494344;2599.181257903754;2599.233226198276;2550.744925507453;2574.201997380799;2589.805764567665;2613.9346516337246;2619.371350875776;9233.769155771159;9305.813883722287;9314.115159059878;9323.393979391318;9325.860112098324;5659.377468478464;5761.251037365158;5797.01450753373;5829.825105246807;5847.210626565402;3689.0961714379882;3765.7740535567677;3816.313063648542;3834.7699138051807;3844.231153769257;1057.804306203347;1068.3910171202417;1075.0432115417284;1085.0614218700846;1115.1190559458018;11390.145739069603;12318.952889004446;12529.248245105231;12542.81185782214;12592.244465332109;5070.467600901852;5072.239164125337;5159.329287192641;5190.740462976836;5247.2653828464045;10592.735181620366;10596.205284603531;10596.682099537025;10629.202809789296;10634.521446534924;5764.827055188351;5766.135079738073;5773.278340207474;5774.422557744276;5776.393478684678;4616.653750968623;4785.353977213102;5039.874003149951;5151;5153.639245252872;3443.328550932544;4065.6137666921595;4154.896127596834;4168.166366726606;4218.957810421918;1366.5558693424678;1385.7020740540631;1386.050555369575;1386.3761307411503;1397.0779285671408;969.3408482232009;1166.078797749785;1169.2283093158474;1301.5834932821595;1414.766563517008;8583.141685831491;8590.527520986281;8631.784205394915;8644.697435589724;8692;534.6925517827265;540.1276937745513;542.2625229687621;546.3307448375788;551.1429726774824;6302.621842689453;6318.810435686937;6368.203974503187;6396.616203027833;6398.584092034003;11046.944765276283;11608.361540115206;11621.360825154698;11629.069674426026;11635.418229088511;10310.175185985254;10814.78370432587;11266.549338026387;11373.976342129248;11388.601398950997;8584.613692383859;8614.138586141462;8641.783955401166;8698.304135669132;8750.081241469554;8388.370872184489;8405.285550728013;8444.071152173134;8503.574821259035;8514.148585141436;9843.803123937625;9867.11195992364;9917.15704165154;9960.950195248977;10065.943075976917;10131.442770647685;10521.263511554118;10543.209259305737;10662.680119596425;10668.466576671291;6559.311272316338;7138.393236574741;7577.16651168382;7706.344960678405;8031.196880311922;8580.65677372923;8592.484450932963;8619.784505387164;8635.827283454422;8637.611307491052;7614;7717.073951125676;7782.143964163824;7834.921650783419;7851.371890248653;7461.701531938662;7567;7617.885731714139;7643;7768.805779855323;8216.712415065444;8226.506409615442;8231.259186673227;8246.711365102192;8254.628541715518;7273.490855640054;7398.11222653285;7413.629318534159;7416.629168541659;7420.220876808074;7485.737999170003;7492.887606686013;7538.09542854861;7545.547267163988;7545.886811697719 03:15:20 INFO - PROCESS | 1668 | |4;prototype.html;334.4782139861815;336.9561956945598;341.7300332737138;341.92306730985547;347.383394474807;5192.766325515351;6430.839229019277;6654.534182607219;6676.332366763321;6697.229818570866;6670.132882725251;6671.799846004627;6685.164354455693;6685.431738302238;6712.993051042346;4696.976515117437;4797.520247975192;4803.591694705954;4869.366982292315;4931.975340123303;4792.209285467894;4859.514048595148;4887.6089912807065;4894.3147959285725;4899.338589290436;4860.295257187706;4879.365682461275;4884.609231261508;4902.901941961159;4910.8281210157475;4682.953170468286;4834.854954351357;4875.8781030474165;4877.073356062355;4885.2916327132725;3495.877644282438;4118.691098167619;4184.267753143188;4238.766867822269;4253.128108737701;6436.388543088399;6449.742010319582;6454.580452270634;6458.289588145347;6470.38531339522;4985.651004429691;5857.121431785266;5857.941420585825;5859.29688437386;5873.706314684291;5726.971365143189;7123.89314160288;7124.038254835583;7128.25153358895;7131.82170445743;4453.977730111361;4612.630989520831;4754.619630429557;4763.285507173917;4771.785269662873;6468.867948109109;7175.856482870313;7366.668499917517;7511.32398084175;7520.059992500937;4707.7175369477945;4708.576228139484;4715.504871988392;4716.528347165325;4720.504347043579;3930.4104384342577;4116.958830411718;4655.9058621223985;4795.568398844051;4827;4606.792694328763;5698.1737648041635;5701.800436984686;5704.743286552115;5707.942920570824;6935.271796461399;7170.677319520634;7171.278893065627;7197.280271972761;7209.6395180241825;1647.826978167299;1657.917104144788;1664.8501634852921;1671.264643556831;1672.1639180409795;1050.9211809114195;1058.0530425269342;1067.4876059491487;1074.3714926767927;1074.8656417947757;6341.302456729756;6451.41937225652;6507.511936604774;6543.770968016097;6638.369354911276;7469.991551140526;7501.437392195608;7504.662290196954;7511.737089201961;7516.511426757353;6632.303608121078;6633.535652504278;6634.767783127664;6636.270010298863;6641.501887358468;3901.297766402075;3943.901402464904;3948.881533553998;3950.7234493585174;3959.3269144245546;7450.105987281561;7671.769846904602;7698.230176982257;7761.107472640719;7785.221477852169;7681.3854891608535;7714.961425192838;7717.498362606412;7738;7740.458167928304;6991.650417479004;7757.418193635387;7788.84422311562;7792.298693117533;7796.961015194887;7211.350978411968;7477.102747670315;7493.363064139609;7501.062367204099;7504.474686772092;7324;7359.8160045999275;7364.926350736424;7382.741604043833;7383.372413344711;6132.693365331626;7718.729844455417;7738.264864837832;7747.070351557849;7750.224977502205;4675.883102922454;4738.715677059387;4738.834140805193;4740.19416699155;4743.620510359094;5978.730957107027;7202.991581178744;7422.109346878409;7437.8140546486775;7446.553206807609;6893.034975103389;7131.215566287808;7215.458840586872;7217.314355136254;7227.421806255592;6069.026177173241;7137.785866424016;7163.570185788869;7170;7179.497435179487;7018.543794653331;7024.894626580503;7032.1912980007955;7049;7067;6849.794506164823;7088.681009354695;7151.499395042297;7177.354038136593;7179.856402871809;6696.866062678817;6859.5541289816;6871.553349032297;6993.4055605274125;7047 03:15:20 INFO - PROCESS | 1668 | |5;yui.html;765.7281665008918;793.3177467378054;794.5034353529045;803.1446509467416;805.6012273924408;15391.153486558249;15636.84363156371;15677.059376437423;15763.290651920648;15766.369345226192;13148.539801106963;14614.050086744353;14614.926925365358;14639.560813175622;14668.779968300458;981.695674340953;989.2234595842265;1001.1190152665644;1005.1004351105756;1005.6379703306803;995.4972738766912;1000.7548150703052;1001.0990108901974;1003.4832061488339;1004.9598016079348;1053.399562249518;1056.9048785609293;1059.6503153959175;1060.0565496707936;1061.8991195836384;1045.4668119259156;1049.9737506562321;1052.3317693264755;1053.2521909444265;1053.931494452858;782.3584660578329;783.2089589514575;784.3058892879785;784.9646765895492;785.3363907498155;13644.65888352799;13688.452461901512;13716.725665486734;13731.313434328244;13874.583762487142;11601.477933493014;11652.366730924838;11659.358735269558;11921.523139074514;12022.458989345501;11144.498497567629;11189.44052797365;11258.943705281503;11440.485178167002;11505.769884602345;3483.5471388719557;3592.8742494012845;3602.3695853225845;3639.6542328478754;3789.5073640426567;56253.43746562564;69949;84513.73229401564;85608;88388.23223535558;9728.951355243178;9744.366616169926;9888.901110988942;10326.01902819231;10471.42407167613;22138.114475421124;22161.22435714742;22164.335069947603;22183.334499965025;22187;7362.8527429451115;7514.135874374517;7803.297703206626;8064.395170362129;8126.634301456449;4124.237016152021;4151.46031015972;4193.622573968358;4217.156568686275;4237.300845360543;3750.5311836020496;3804;3812.4662547243406;3812.942805857914;3814.809259537012;552.0807854921511;567.5232804444204;571.2003195526213;572.5448268626452;584.9385814489502;554.5785203245563;602.4758460139619;604.7157835817159;613.0773186354508;650.0444346810182;8043.597820108971;8447.831043379098;8488.787780305542;8493.065762766091;8547.316214702809;539.463234082083;559.8572364047142;596.5347029317139;615.0712424239431;620.2928661326092;3828.291766023239;3858.6141385861188;3970.1265721541213;3973.0266084809405;4003.799810009488;98695;99406.5029674847;100313;100472.4976375128;102157.446063849;83505.74741378883;84943.30113397697;85003.57498212469;86255.56872215724;88202;62349.37650623436;74087;74363.62818185874;75280.62359688277;76003.61998189974;8370.204830541088;8657.696980605648;8739.519326437106;8805.16350946659;8970.730878073668;37300;52476;53026;53306;53756.73121634523;70912;71044.64477677786;71353.64323178351;72841;73417;11137.109031277316;11339.546418143513;11596.420178991186;11619.30284182918;11658.30050196957;11968.46141923598;12196.024318054711;12385.133040687066;12437.315947622968;12493.93753031229;11921.821172682243;11928.403579821148;12081.577144800242;12128.393580320771;12246;11548.42257887119;11803.23278986863;11834;11953.880461195276;12079.879201207876;11705.590304339306;11764.99997500222;11872.643820685393;11951.581694640647;12312.199707019015;9806.117449429586;10132.544035518567;10158.898411015794;10402.27184097106;10457.58169673235;9483.288753343664;9774.951125244328;10039.060164610823;10078;10112.84830727525 03:15:20 INFO - PROCESS | 1668 | __end_tp_report 03:15:20 INFO - PROCESS | 1668 | __start_cc_report 03:15:20 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1284 03:15:20 INFO - PROCESS | 1668 | __end_cc_report 03:15:20 INFO - PROCESS | 1668 | __startTimestamp1458036920216__endTimestamp 03:15:20 INFO - PROCESS | 1668 | 03:15:20 INFO - PROCESS | 1668 | ------- Summary: start ------- 03:15:20 INFO - PROCESS | 1668 | Number of tests: 6 03:15:20 INFO - PROCESS | 1668 | 03:15:20 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5784.42 Median:6045.37 stddev:637.10 (10.5%) stddev-sans-first:612.19 03:15:20 INFO - PROCESS | 1668 | Values: 3450.8 3515.1 3515.2 3526.5 3578.9 5844.7 5864.2 5870.9 5879.0 5892.9 5823.9 5858.9 5874.9 5906.5 5929.8 5164.0 5192.5 5233.9 5236.7 5286.8 5268.9 5283.9 5297.6 5298.4 5298.9 5270.5 5273.7 5310.9 5313.8 5327.3 5328.4 5333.2 5353.0 5359.9 5361.1 5085.7 5230.0 5279.5 5285.8 5288.3 5680.7 5774.7 5777.9 5782.0 5802.4 6123.4 6208.5 6222.7 6228.9 6233.4 6182.7 6216.6 6229.8 6255.0 6307.7 5961.9 5970.0 5970.9 5972.6 6020.0 6238.3 6282.9 6323.9 6368.6 6387.2 6259.2 6259.6 6272.1 6280.7 6291.3 6292.7 6294.7 6301.7 6304.6 6306.7 6104.7 6242.0 6243.4 6304.2 6313.3 6272.3 6287.6 6305.6 6310.1 6320.6 4966.3 4971.1 4976.6 4977.0 4994.7 4389.0 4419.4 4466.4 4487.2 4531.9 4813.4 5741.5 5753.4 5765.2 5789.5 6240.0 6258.7 6280.1 6282.6 6283.7 5589.0 5601.0 5656.6 5744.3 5744.7 5401.0 5408.8 5409.8 5410.7 5415.2 6400.1 6401.4 6401.8 6412.2 6422.8 6187.2 6213.3 6254.1 6261.8 6284.9 5375.8 6343.2 6390.8 6396.4 6407.9 6235.0 6268.4 6271.1 6278.1 6293.9 6193.8 6216.1 6241.3 6281.0 6312.2 6017.9 6045.4 6119.5 6206.1 6235.0 5123.6 5190.9 5763.2 6171.1 6174.7 4953.9 5986.7 6050.3 6051.3 6076.3 6079.4 6109.8 6215.2 6219.6 6226.6 6060.9 6074.9 6121.6 6122.8 6134.7 03:15:20 INFO - PROCESS | 1668 | 03:15:20 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:60558.35 Median:38950.92 stddev:122669.71 (314.9%) stddev-sans-first:122930.87 03:15:20 INFO - PROCESS | 1668 | Values: 470.2 563.7 589.9 630.1 645.4 26457.9 32083.4 39151.8 39654.0 39757.4 42669.4 43261.1 43341.0 43406.9 43482.1 9527.3 9753.8 9755.3 9760.7 9764.5 9505.4 9634.6 9644.8 9645.2 9657.0 9733.7 9734.0 9803.9 9808.5 9813.5 9725.1 9801.8 9814.8 9820.0 9853.0 9600.9 9720.8 9742.1 9742.7 9747.1 41718.0 42094.0 42102.8 42109.0 42220.0 3271.7 3365.8 3467.9 3563.4 3827.5 26567.7 27210.0 27313.8 27419.7 27960.0 2739.3 2756.9 2778.0 2792.9 2887.8 495131.0 499322.0 499671.0 500482.0 500597.0 46774.8 47585.0 71392.6 71701.6 71981.0 48223.0 48239.0 48646.0 48676.0 48772.5 17027.8 17150.7 17170.1 17170.1 17183.7 13592.7 13626.2 13662.8 13678.3 13681.0 15188.9 15229.7 15243.5 15266.8 15317.2 5907.8 6059.0 6524.1 6661.9 6713.6 970.3 1024.7 1099.5 1099.8 1102.2 29733.9 29960.0 30242.5 30625.4 30850.0 1155.9 1156.1 1165.9 1199.5 1267.7 15329.9 15387.8 15501.6 15736.2 15749.3 516881.0 519543.0 524810.0 527041.0 527996.0 60243.0 60866.4 60893.0 61009.0 61037.0 1403.3 1420.1 1516.4 1532.6 1569.5 29146.3 29420.4 29515.0 30168.5 30471.7 39476.8 48289.0 48448.8 48559.0 48815.5 339540.0 340025.3 341289.0 342828.0 342947.0 34298.0 44244.7 44831.0 46619.3 46648.5 45244.9 45459.0 45772.3 46187.2 46430.0 37747.8 38088.6 38100.6 38125.8 38712.4 37353.1 38120.4 38229.2 38854.2 38962.6 37867.6 38297.2 38620.2 38669.0 38939.2 32212.0 33572.8 33967.0 34013.1 34107.5 25442.2 25622.2 25630.6 25799.0 25963.0 03:15:20 INFO - PROCESS | 1668 | 03:15:20 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:36509.66 Median:21401.91 stddev:108959.23 (509.1%) stddev-sans-first:109231.12 03:15:20 INFO - PROCESS | 1668 | Values: 384.7 386.1 388.1 394.8 397.1 16807.0 17144.7 19824.7 21137.9 21621.6 17703.8 17981.5 19915.8 20615.3 22031.4 5362.0 5924.7 6168.0 6168.6 6181.5 4406.9 5809.6 5931.1 6007.8 6078.5 4588.1 4596.8 4600.7 6309.8 6579.5 6333.1 6557.7 6562.1 6564.1 6605.0 5751.6 5798.1 5805.1 5806.4 5806.9 25408.7 25944.4 26417.6 26441.0 26466.0 2231.1 2333.9 2364.2 2368.6 2411.8 14643.4 15205.4 15285.5 15383.9 15527.5 1685.5 1785.3 1799.7 1816.6 1918.6 101553.5 107955.5 110288.3 111839.0 113816.0 9429.6 11023.4 11411.8 11844.7 11952.9 14078.9 14104.0 14165.4 14200.9 14249.4 8822.7 8882.9 8883.5 8892.2 8958.5 9014.9 9019.0 9020.4 9079.8 9092.0 4632.2 4693.0 4718.2 4722.0 4726.0 1556.6 1923.9 1984.2 1986.2 2014.2 863.9 969.7 1001.3 1068.3 1114.8 16815.4 20008.5 21002.0 21152.9 21182.3 1011.8 1015.6 1030.3 1063.5 1068.4 11164.6 11479.5 11495.6 11498.7 11698.3 628150.0 634834.0 650025.0 682939.0 691110.0 119457.0 122024.4 122336.0 123795.0 127755.0 911.2 1046.1 1054.5 1062.3 1063.3 18990.4 19081.7 19089.7 19103.6 19388.6 50009.7 51243.7 53037.7 53896.5 55265.0 77572.0 77954.6 78544.0 79030.0 80705.6 8482.6 8509.8 8552.1 8563.8 8618.9 9992.7 11713.7 13249.3 13619.7 14012.0 11262.0 11477.6 11873.7 11930.4 12134.6 9459.9 11600.9 11613.1 11827.1 11836.8 11842.9 11848.1 11972.4 12201.7 12277.0 8095.1 8322.7 8337.7 8554.8 8833.9 8687.9 11154.8 11912.8 12029.4 12144.3 03:15:20 INFO - PROCESS | 1668 | 03:15:20 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:6336.35 Median:537.41 stddev:3380.96 (629.1%) stddev-sans-first:3370.82 03:15:20 INFO - PROCESS | 1668 | Values: 1489.9 1525.0 1689.4 1980.7 2096.9 8463.2 9062.0 9213.9 9227.0 9234.9 8899.1 9159.3 9161.7 9161.9 9169.1 2238.4 2521.2 2560.6 2589.2 2600.0 2578.3 2580.4 2582.5 2582.7 2582.9 2436.6 2516.0 2520.8 2521.7 2522.2 2533.2 2586.7 2596.2 2599.2 2599.2 2550.7 2574.2 2589.8 2613.9 2619.4 9233.8 9305.8 9314.1 9323.4 9325.9 5659.4 5761.3 5797.0 5829.8 5847.2 3689.1 3765.8 3816.3 3834.8 3844.2 1057.8 1068.4 1075.0 1085.1 1115.1 11390.1 12319.0 12529.2 12542.8 12592.2 5070.5 5072.2 5159.3 5190.7 5247.3 10592.7 10596.2 10596.7 10629.2 10634.5 5764.8 5766.1 5773.3 5774.4 5776.4 4616.7 4785.4 5039.9 5151.0 5153.6 3443.3 4065.6 4154.9 4168.2 4219.0 1366.6 1385.7 1386.1 1386.4 1397.1 969.3 1166.1 1169.2 1301.6 1414.8 8583.1 8590.5 8631.8 8644.7 8692.0 534.7 540.1 542.3 546.3 551.1 6302.6 6318.8 6368.2 6396.6 6398.6 11046.9 11608.4 11621.4 11629.1 11635.4 10310.2 10814.8 11266.5 11374.0 11388.6 8584.6 8614.1 8641.8 8698.3 8750.1 8388.4 8405.3 8444.1 8503.6 8514.1 9843.8 9867.1 9917.2 9961.0 10065.9 10131.4 10521.3 10543.2 10662.7 10668.5 6559.3 7138.4 7577.2 7706.3 8031.2 8580.7 8592.5 8619.8 8635.8 8637.6 7614.0 7717.1 7782.1 7834.9 7851.4 7461.7 7567.0 7617.9 7643.0 7768.8 8216.7 8226.5 8231.3 8246.7 8254.6 7273.5 7398.1 7413.6 7416.6 7420.2 7485.7 7492.9 7538.1 7545.5 7545.9 03:15:20 INFO - PROCESS | 1668 | 03:15:20 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:5804.19 Median:6588.04 stddev:1870.73 (28.4%) stddev-sans-first:1830.38 03:15:20 INFO - PROCESS | 1668 | Values: 334.5 337.0 341.7 341.9 347.4 5192.8 6430.8 6654.5 6676.3 6697.2 6670.1 6671.8 6685.2 6685.4 6713.0 4697.0 4797.5 4803.6 4869.4 4932.0 4792.2 4859.5 4887.6 4894.3 4899.3 4860.3 4879.4 4884.6 4902.9 4910.8 4683.0 4834.9 4875.9 4877.1 4885.3 3495.9 4118.7 4184.3 4238.8 4253.1 6436.4 6449.7 6454.6 6458.3 6470.4 4985.7 5857.1 5857.9 5859.3 5873.7 5727.0 7123.9 7124.0 7128.3 7131.8 4454.0 4612.6 4754.6 4763.3 4771.8 6468.9 7175.9 7366.7 7511.3 7520.1 4707.7 4708.6 4715.5 4716.5 4720.5 3930.4 4117.0 4655.9 4795.6 4827.0 4606.8 5698.2 5701.8 5704.7 5707.9 6935.3 7170.7 7171.3 7197.3 7209.6 1647.8 1657.9 1664.9 1671.3 1672.2 1050.9 1058.1 1067.5 1074.4 1074.9 6341.3 6451.4 6507.5 6543.8 6638.4 7470.0 7501.4 7504.7 7511.7 7516.5 6632.3 6633.5 6634.8 6636.3 6641.5 3901.3 3943.9 3948.9 3950.7 3959.3 7450.1 7671.8 7698.2 7761.1 7785.2 7681.4 7715.0 7717.5 7738.0 7740.5 6991.7 7757.4 7788.8 7792.3 7797.0 7211.4 7477.1 7493.4 7501.1 7504.5 7324.0 7359.8 7364.9 7382.7 7383.4 6132.7 7718.7 7738.3 7747.1 7750.2 4675.9 4738.7 4738.8 4740.2 4743.6 5978.7 7203.0 7422.1 7437.8 7446.6 6893.0 7131.2 7215.5 7217.3 7227.4 6069.0 7137.8 7163.6 7170.0 7179.5 7018.5 7024.9 7032.2 7049.0 7067.0 6849.8 7088.7 7151.5 7177.4 7179.9 6696.9 6859.6 6871.6 6993.4 7047.0 03:15:20 INFO - PROCESS | 1668 | 03:15:20 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:18988.21 Median:3796.75 stddev:27012.93 (711.5%) stddev-sans-first:27054.06 03:15:20 INFO - PROCESS | 1668 | Values: 765.7 793.3 794.5 803.1 805.6 15391.2 15636.8 15677.1 15763.3 15766.4 13148.5 14614.1 14614.9 14639.6 14668.8 981.7 989.2 1001.1 1005.1 1005.6 995.5 1000.8 1001.1 1003.5 1005.0 1053.4 1056.9 1059.7 1060.1 1061.9 1045.5 1050.0 1052.3 1053.3 1053.9 782.4 783.2 784.3 785.0 785.3 13644.7 13688.5 13716.7 13731.3 13874.6 11601.5 11652.4 11659.4 11921.5 12022.5 11144.5 11189.4 11258.9 11440.5 11505.8 3483.5 3592.9 3602.4 3639.7 3789.5 56253.4 69949.0 84513.7 85608.0 88388.2 9729.0 9744.4 9888.9 10326.0 10471.4 22138.1 22161.2 22164.3 22183.3 22187.0 7362.9 7514.1 7803.3 8064.4 8126.6 4124.2 4151.5 4193.6 4217.2 4237.3 3750.5 3804.0 3812.5 3812.9 3814.8 552.1 567.5 571.2 572.5 584.9 554.6 602.5 604.7 613.1 650.0 8043.6 8447.8 8488.8 8493.1 8547.3 539.5 559.9 596.5 615.1 620.3 3828.3 3858.6 3970.1 3973.0 4003.8 98695.0 99406.5 100313.0 100472.5 102157.4 83505.7 84943.3 85003.6 86255.6 88202.0 62349.4 74087.0 74363.6 75280.6 76003.6 8370.2 8657.7 8739.5 8805.2 8970.7 37300.0 52476.0 53026.0 53306.0 53756.7 70912.0 71044.6 71353.6 72841.0 73417.0 11137.1 11339.5 11596.4 11619.3 11658.3 11968.5 12196.0 12385.1 12437.3 12493.9 11921.8 11928.4 12081.6 12128.4 12246.0 11548.4 11803.2 11834.0 11953.9 12079.9 11705.6 11765.0 11872.6 11951.6 12312.2 9806.1 10132.5 10158.9 10402.3 10457.6 9483.3 9775.0 10039.1 10078.0 10112.8 03:15:20 INFO - PROCESS | 1668 | -------- Summary: end -------- 03:15:20 INFO - PROCESS | 1668 | 03:15:20 INFO - TEST-INFO | 1668: exit 0 03:15:20 INFO - TEST-OK | dromaeo_css | took 1113001ms 03:15:20 INFO - TEST-START | kraken 03:15:20 INFO - operating with platform_type : mac_ 03:15:20 INFO - Initialising browser for kraken test... 03:15:20 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmpRUP6dZ/profile http://localhost:49270/getInfo.html) 03:15:22 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 03:15:22 INFO - PROCESS | 1673 | colorDepth:24 03:15:22 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 03:15:22 INFO - PROCESS | 1673 | __metrics 03:15:22 INFO - PROCESS | 1673 | 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" 03:15:22 INFO - PROCESS | 1673 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:15:23 INFO - TEST-INFO | 1673: exit 0 03:15:23 INFO - Browser initialized. 03:15:23 INFO - Running cycle 1/1 for kraken test... 03:15:23 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmpRUP6dZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:15:35 INFO - PROCESS | 1676 | RSS: Main: 209166336 03:15:35 INFO - PROCESS | 1676 | 03:15:37 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 03:15:38 INFO - PROCESS | 1676 | RSS: Main: 264183808 03:15:38 INFO - PROCESS | 1676 | 03:15:41 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 03:15:41 INFO - PROCESS | 1676 | RSS: Main: 274472960 03:15:41 INFO - PROCESS | 1676 | 03:15:44 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 03:15:45 INFO - PROCESS | 1676 | RSS: Main: 264732672 03:15:45 INFO - PROCESS | 1676 | 03:15:47 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 03:15:47 INFO - PROCESS | 1676 | RSS: Main: 267255808 03:15:47 INFO - PROCESS | 1676 | 03:15:50 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:15:50 INFO - PROCESS | 1676 | RSS: Main: 267763712 03:15:50 INFO - PROCESS | 1676 | 03:15:53 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 03:15:53 INFO - PROCESS | 1676 | RSS: Main: 267055104 03:15:53 INFO - PROCESS | 1676 | 03:15:56 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 03:15:57 INFO - PROCESS | 1676 | RSS: Main: 267800576 03:15:57 INFO - PROCESS | 1676 | 03:16:00 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 03:16:00 INFO - PROCESS | 1676 | RSS: Main: 269414400 03:16:00 INFO - PROCESS | 1676 | 03:16:02 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:16:02 INFO - PROCESS | 1676 | RSS: Main: 301068288 03:16:02 INFO - PROCESS | 1676 | 03:16:04 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:16:05 INFO - PROCESS | 1676 | RSS: Main: 302522368 03:16:05 INFO - PROCESS | 1676 | 03:16:07 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:16:08 INFO - PROCESS | 1676 | RSS: Main: 307691520 03:16:08 INFO - PROCESS | 1676 | 03:16:10 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:16:11 INFO - PROCESS | 1676 | RSS: Main: 310067200 03:16:11 INFO - PROCESS | 1676 | 03:16:13 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:16:14 INFO - PROCESS | 1676 | RSS: Main: 309911552 03:16:14 INFO - PROCESS | 1676 | 03:16:15 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 03:16:16 INFO - PROCESS | 1676 | RSS: Main: 370298880 03:16:16 INFO - PROCESS | 1676 | 03:16:16 INFO - PROCESS | 1676 | __start_tp_report 03:16:16 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 03:16:16 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 03:16:16 INFO - PROCESS | 1676 | |i|pagename|runs| 03:16:16 INFO - PROCESS | 1676 | |0;ai-astar;112;110;111;111;113;111;121;112;110;112 03:16:16 INFO - PROCESS | 1676 | |1;audio-beat-detection;152;120;137;156;118;138;120;137;166;99 03:16:16 INFO - PROCESS | 1676 | |2;audio-dft;184;186;183;186;188;187;186;185;185;184 03:16:16 INFO - PROCESS | 1676 | |3;audio-fft;75;74;72;121;55;57;57;58;125;78 03:16:16 INFO - PROCESS | 1676 | |4;audio-oscillator;90;95;130;80;79;89;115;76;78;116 03:16:16 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;86;84;86;83;86;84;86;84;90;129 03:16:16 INFO - PROCESS | 1676 | |6;imaging-darkroom;92;93;93;93;92;92;92;93;107;150 03:16:16 INFO - PROCESS | 1676 | |7;imaging-desaturate;87;88;85;86;87;87;87;87;85;89 03:16:16 INFO - PROCESS | 1676 | |8;json-parse-financial;54;57;55;59;83;89;79;67;53;53 03:16:16 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;62;61;72;75;70;66;66;66;66;66 03:16:16 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;78;80;81;77;81;80;78;80;79;84 03:16:16 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;123;124;127;117;119;128;114;114;108;116 03:16:16 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;132;132;134;131;132;132;133;132;133;131 03:16:16 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;65;66;66;66;67;66;68;77;96;96 03:16:16 INFO - PROCESS | 1676 | __end_tp_report 03:16:16 INFO - PROCESS | 1676 | __start_cc_report 03:16:16 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1198 03:16:16 INFO - PROCESS | 1676 | __end_cc_report 03:16:16 INFO - PROCESS | 1676 | __startTimestamp1458036976101__endTimestamp 03:16:16 INFO - PROCESS | 1676 | 03:16:16 INFO - PROCESS | 1676 | ------- Summary: start ------- 03:16:16 INFO - PROCESS | 1676 | Number of tests: 14 03:16:16 INFO - PROCESS | 1676 | 03:16:16 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:3.20 (2.9%) stddev-sans-first:3.39 03:16:16 INFO - PROCESS | 1676 | Values: 112.0 110.0 111.0 111.0 113.0 111.0 121.0 112.0 110.0 112.0 03:16:16 INFO - PROCESS | 1676 | 03:16:16 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:145.00 stddev:20.38 (14.1%) stddev-sans-first:20.59 03:16:16 INFO - PROCESS | 1676 | Values: 152.0 120.0 137.0 156.0 118.0 138.0 120.0 137.0 166.0 99.0 03:16:16 INFO - PROCESS | 1676 | 03:16:16 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:185.40 Median:186.00 stddev:1.51 (0.8%) stddev-sans-first:1.51 03:16:16 INFO - PROCESS | 1676 | Values: 184.0 186.0 183.0 186.0 188.0 187.0 186.0 185.0 185.0 184.0 03:16:16 INFO - PROCESS | 1676 | 03:16:16 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:77.20 Median:65.00 stddev:25.65 (39.5%) stddev-sans-first:27.20 03:16:16 INFO - PROCESS | 1676 | Values: 75.0 74.0 72.0 121.0 55.0 57.0 57.0 58.0 125.0 78.0 03:16:16 INFO - PROCESS | 1676 | 03:16:16 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:79.50 stddev:19.03 (23.9%) stddev-sans-first:20.10 03:16:16 INFO - PROCESS | 1676 | Values: 90.0 95.0 130.0 80.0 79.0 89.0 115.0 76.0 78.0 116.0 03:16:16 INFO - PROCESS | 1676 | 03:16:16 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:89.80 Median:86.00 stddev:13.91 (16.2%) stddev-sans-first:14.69 03:16:16 INFO - PROCESS | 1676 | Values: 86.0 84.0 86.0 83.0 86.0 84.0 86.0 84.0 90.0 129.0 03:16:16 INFO - PROCESS | 1676 | 03:16:16 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:99.70 Median:92.50 stddev:18.26 (19.7%) stddev-sans-first:19.15 03:16:16 INFO - PROCESS | 1676 | Values: 92.0 93.0 93.0 93.0 92.0 92.0 92.0 93.0 107.0 150.0 03:16:16 INFO - PROCESS | 1676 | 03:16:16 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:86.80 Median:87.00 stddev:1.23 (1.4%) stddev-sans-first:1.30 03:16:16 INFO - PROCESS | 1676 | Values: 87.0 88.0 85.0 86.0 87.0 87.0 87.0 87.0 85.0 89.0 03:16:16 INFO - PROCESS | 1676 | 03:16:16 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:63.00 stddev:13.78 (21.9%) stddev-sans-first:14.04 03:16:16 INFO - PROCESS | 1676 | Values: 54.0 57.0 55.0 59.0 83.0 89.0 79.0 67.0 53.0 53.0 03:16:16 INFO - PROCESS | 1676 | 03:16:16 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:66.00 stddev:4.27 (6.5%) stddev-sans-first:4.13 03:16:16 INFO - PROCESS | 1676 | Values: 62.0 61.0 72.0 75.0 70.0 66.0 66.0 66.0 66.0 66.0 03:16:16 INFO - PROCESS | 1676 | 03:16:16 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:80.00 stddev:1.99 (2.5%) stddev-sans-first:2.00 03:16:16 INFO - PROCESS | 1676 | Values: 78.0 80.0 81.0 77.0 81.0 80.0 78.0 80.0 79.0 84.0 03:16:16 INFO - PROCESS | 1676 | 03:16:16 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:121.00 stddev:6.41 (5.3%) stddev-sans-first:6.64 03:16:16 INFO - PROCESS | 1676 | Values: 123.0 124.0 127.0 117.0 119.0 128.0 114.0 114.0 108.0 116.0 03:16:16 INFO - PROCESS | 1676 | 03:16:16 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:132.20 Median:132.00 stddev:0.92 (0.7%) stddev-sans-first:0.97 03:16:16 INFO - PROCESS | 1676 | Values: 132.0 132.0 134.0 131.0 132.0 132.0 133.0 132.0 133.0 131.0 03:16:16 INFO - PROCESS | 1676 | 03:16:16 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:67.50 stddev:12.45 (18.4%) stddev-sans-first:12.83 03:16:16 INFO - PROCESS | 1676 | Values: 65.0 66.0 66.0 66.0 67.0 66.0 68.0 77.0 96.0 96.0 03:16:16 INFO - PROCESS | 1676 | -------- Summary: end -------- 03:16:16 INFO - PROCESS | 1676 | 03:16:16 INFO - TEST-INFO | 1676: exit 0 03:16:16 INFO - TEST-OK | kraken | took 56056ms 03:16:16 INFO - SUITE-END | took 1169s 03:16:17 INFO - Completed test suite (00:19:29) 03:16:17 INFO - javascript benchmark 03:16:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3450.84471198796, 3515.1387909962064, 3515.1563624730074, 3526.506289119524, 3578.8568457261713, 5844.707764611774, 5864.179014937912, 5870.853228669285, 5878.970605146974, 5892.85267868303, 5823.912641310373, 5858.853528661785, 5874.88250234995, 5906.497947674442, 5929.762809487626, 5163.974180129094, 5192.532672059505, 5233.921491177635, 5236.659617124875, 5286.814961476349, 5268.92096618551, 5283.947160528403, 5297.629165958385, 5298.4436634153435, 5298.92051619226, 5270.4729527047375, 5273.736313184345, 5310.893782124355, 5313.787448502056, 5327.334083239595, 5328.413874473805, 5333.173358129496, 5353.03645343838, 5359.946400536003, 5361.142217245222, 5085.694858308476, 5230.0, 5279.524842764131, 5285.841424757264, 5288.338957630296, 5680.659160450345, 5774.740136693859, 5777.855553611152, 5782.045962416196, 5802.419758024206, 6123.4488895999575, 6208.534359922979, 6222.688865556749, 6228.87542249157, 6233.376662333776, 6182.659953702545, 6216.627002379872, 6229.7508099676415, 6255.030470277115, 6307.653079080649, 5961.910571341434, 5969.970150149265, 5970.850728731816, 5972.581919265654, 6020.036794112921, 6238.313785483593, 6282.937170628326, 6323.873522529524, 6368.5860419072615, 6387.169667943138, 6259.217597800275, 6259.593126446766, 6272.1219029335925, 6280.685965701697, 6291.339409362043, 6292.716827742671, 6294.685265736694, 6301.7164227609865, 6304.558680892385, 6306.716197771111, 6104.664243466652, 6242.032484964838, 6243.406876346739, 6304.18045654062, 6313.273973493016, 6272.278687950853, 6287.591306565058, 6305.5901366411035, 6310.116583678288, 6320.55756097078, 4966.329545511309, 4971.130052240916, 4976.576990955737, 4977.029479251583, 4994.650374473752, 4389.034412429261, 4419.447569053868, 4466.39703640011, 4487.192305384997, 4531.864044078683, 4813.350197723263, 5741.45456181662, 5753.367129615739, 5765.221695071195, 5789.45000224978, 6240.032794916795, 6258.749650013949, 6280.1207830902795, 6282.560220784501, 6283.6858157091965, 5588.972055139699, 5601.0, 5656.632318899258, 5744.339400968858, 5744.741486633112, 5401.0, 5408.810691625774, 5409.810656626999, 5410.675359478365, 5415.214793854948, 6400.0719895614875, 6401.423871851555, 6401.775937842153, 6412.23053233615, 6422.775202867877, 6187.195664563578, 6213.316535181217, 6254.124422580933, 6261.78083767066, 6284.937150628435, 5375.844193498417, 6343.175387199819, 6390.808275751735, 6396.392342727433, 6407.8718425630295, 6234.9688251558455, 6268.373162683695, 6271.090691849748, 6278.089676996901, 6293.874122517615, 6193.81418557444, 6216.098665693358, 6241.251049874044, 6280.9685951569945, 6312.179416675803, 6017.939820601738, 6045.365236650088, 6119.502553941335, 6206.06908963659, 6235.0, 5123.5644970177955, 5190.8961820762615, 5763.193152958673, 6171.105189747551, 6174.6912654368, 4953.900921981468, 5986.730597123053, 6050.273967123973, 6051.304100028553, 6076.33160352352, 6079.361667024898, 6109.816705498843, 6215.192025036717, 6219.564630475823, 6226.59527130735, 6060.878692457604, 6074.878502430015, 6121.574916084878, 6122.77432918503, 6134.7059205304895], "unit": "score", "name": "dojo.html", "value": 5745.837274767373}, {"lowerIsBetter": false, "replicates": [470.17953670844383, 563.7463141586287, 589.8645108166778, 630.0832289019477, 645.3868824616615, 26457.867710661445, 32083.35833283336, 39151.82544523665, 39654.0, 39757.40363894544, 42669.35995960063, 43261.13477730443, 43341.0, 43406.91482712934, 43482.13035739283, 9527.285453590992, 9753.829540455155, 9755.268354873377, 9760.658376956808, 9764.51177441125, 9505.42967421957, 9634.614615415376, 9644.75888102796, 9645.1801596864, 9657.0, 9733.707988760349, 9734.0, 9803.901960980405, 9808.46053467059, 9813.460259685715, 9725.12473877351, 9801.754956126048, 9814.803703925882, 9820.0, 9853.0, 9600.855987160197, 9720.75698107546, 9742.123208911233, 9742.707718768377, 9747.122758951728, 41718.0, 42094.0, 42102.78948605268, 42109.0, 42220.0, 3271.7055465008025, 3365.7643964922463, 3467.9133021674406, 3563.376409128392, 3827.5215598050245, 26567.734322656914, 27210.047648332213, 27313.76524283672, 27419.725802741916, 27960.0, 2739.260399692092, 2756.8621568921476, 2777.9722202777916, 2792.9022484212956, 2887.826730396183, 495131.0, 499322.0067799312, 499671.0, 500482.0, 500597.0, 46774.76612616983, 47585.0, 71392.64303678552, 71701.64149179221, 71981.0, 48223.0, 48239.0, 48646.02707945821, 48676.0, 48772.51227487751, 17027.829721702874, 17150.742738858928, 17170.055646939287, 17170.141492925555, 17183.656326873643, 13592.728145437035, 13626.182429054288, 13662.795058074136, 13678.31608419575, 13680.973926955518, 15188.860835437386, 15229.695406092038, 15243.466478673416, 15266.770998435033, 15317.157556334509, 5907.763689452459, 6058.969975104243, 6524.054012168209, 6661.933380666132, 6713.56361836479, 970.3256236915277, 1024.6772266735954, 1099.5491848342142, 1099.771379047561, 1102.2229328323513, 29733.851330743208, 29960.0, 30242.54636180459, 30625.387492250476, 30850.0, 1155.92486488378, 1156.109795457493, 1165.906727461801, 1199.4602428907026, 1267.689416093063, 15329.923350383177, 15387.846121538865, 15501.612459688598, 15736.213189340488, 15749.291281892343, 516881.0, 519543.0, 524810.0, 527041.0, 527996.0, 60243.0, 60866.391336086956, 60893.0, 61009.0, 61037.0, 1403.3053638449032, 1420.1408148070475, 1516.4313382481569, 1532.6245069957931, 1569.4506922577007, 29146.27134321659, 29420.411591768472, 29515.0, 30168.54747178838, 30471.695283046887, 39476.80261598674, 48289.0, 48448.788780280775, 48559.02881942412, 48815.511844882516, 339540.0, 340025.2998735089, 341289.0, 342828.0, 342947.0, 34298.0, 44244.695371634196, 44831.0, 46619.30071048869, 46648.53351466442, 45244.86887827831, 45459.0, 45772.31341529946, 46187.15251389907, 46430.0, 37747.81126094352, 38088.61911380962, 38100.61899380971, 38125.80937095297, 38712.41931370975, 37353.0661733448, 38120.42819357656, 38229.23541529098, 38854.222915540966, 38962.6103738959, 37867.62132378641, 38297.23405531818, 38620.227595448494, 38669.0, 38939.221215574966, 32212.0, 33572.83213583916, 33966.98099057032, 34013.14967125842, 34107.48838767371, 25442.236732898044, 25622.231333060037, 25630.615540767278, 25799.0, 25962.961481541282], "unit": "score", "name": "ext.html", "value": 19673.020641151852}, {"lowerIsBetter": false, "replicates": [384.66534115319666, 386.0599440362717, 388.0628282697288, 394.81838354356995, 397.1084914367246, 16806.991580505146, 17144.657106857856, 19824.70262946057, 21137.894310528445, 21621.567568648636, 17703.82296177038, 17981.4605561833, 19915.80084199161, 20615.278465253683, 22031.449213769665, 5361.973190134064, 5924.703764811753, 6167.969160154215, 6168.599041062339, 6181.536384771138, 4406.86779396617, 5809.622374545662, 5931.08068249422, 6007.7596896124105, 6078.513718902477, 4588.082383523292, 4596.839110631112, 4600.700954437968, 6309.810705678837, 6579.506537009719, 6333.113364129025, 6557.672116394185, 6562.081308616797, 6564.146660934096, 6604.966975165142, 5751.597388182829, 5798.130280457923, 5805.129230615399, 5806.361300256968, 5806.941930580725, 25408.745912540824, 25944.351391215183, 26417.603735943976, 26441.0, 26466.0, 2231.141010710872, 2333.8949747261413, 2364.1961733010685, 2368.585497537941, 2411.8311718179734, 14643.41426342945, 15205.391784328614, 15285.541433756895, 15383.923080384639, 15527.456539021194, 1685.5280521454013, 1785.276962830056, 1799.703048996914, 1816.5640246340915, 1918.5779128591687, 101553.49223253911, 107955.46022269917, 110288.34567481495, 111839.0, 113816.0, 9429.575669094907, 11023.393713345682, 11411.771764564828, 11844.70388240301, 11952.88047119535, 14078.929605351908, 14104.012719109563, 14165.362558684885, 14200.928995355163, 14249.358778854768, 8822.691205807765, 8882.911170888337, 8883.511406872554, 8892.15524525169, 8958.507282099547, 9014.909850901407, 9018.954905225432, 9020.368574199743, 9079.81840363189, 9092.0, 4632.16621008215, 4692.95307046932, 4718.221493453541, 4721.95278047222, 4725.976370118127, 1556.5563814312866, 1923.8653294269266, 1984.1567333883331, 1986.1658103596524, 2014.1943222711034, 863.9049704532497, 969.6703120938773, 1001.329109496639, 1068.2682362581656, 1114.788190243851, 16815.41146059882, 20008.49978750543, 21002.0, 21152.894235528725, 21182.258620948192, 1011.8026984738052, 1015.5582321690089, 1030.314840630987, 1063.4948399510172, 1068.4016950507585, 11164.609238676607, 11479.540818367172, 11495.597654082067, 11498.655040348804, 11698.2981021139, 628150.0, 634834.0, 650025.0, 682939.0, 691110.0, 119457.0, 122024.38987805005, 122336.0, 123795.0, 127755.0, 911.2436677557612, 1046.0951277145366, 1054.4516851237313, 1062.3201151263197, 1063.3407287481657, 18990.43028709141, 19081.71377429312, 19089.71365429492, 19103.61792764109, 19388.612227755082, 50009.749951250014, 51243.74378128086, 53037.734811325696, 53896.46103538915, 55265.0, 77572.0, 77954.6102269485, 78544.0, 79030.0, 80705.59647201726, 8482.61828217744, 8509.829803403773, 8552.059273479788, 8563.828723425371, 8618.913810862063, 9992.700218993441, 11713.707157321136, 13249.271290079138, 13619.727605447637, 14012.0, 11262.0, 11477.598284060017, 11873.703157421134, 11930.4034798258, 12134.575289864812, 9459.905400945903, 11600.88399115998, 11613.070954323464, 11827.053835692952, 11836.76326473483, 11842.940785296018, 11848.111391645489, 11972.386784818711, 12201.69495762613, 12277.017838572714, 8095.109537950939, 8322.70870519529, 8337.66337583453, 8554.828903422022, 8833.911660883308, 8687.91312086871, 11154.832677509681, 11912.761744764883, 12029.398530073637, 12144.33206173669], "unit": "score", "name": "jquery.html", "value": 9824.071075924736}, {"lowerIsBetter": false, "replicates": [1489.9404023839047, 1525.0087443161935, 1689.3833750681001, 1980.6533856575095, 2096.909607004358, 8463.153684631534, 9061.954690226548, 9213.907860921388, 9227.0, 9234.907650923496, 8899.065598112202, 9159.313051521129, 9161.725148245547, 9161.946376166743, 9169.128932751395, 2238.3956331790487, 2521.205820166651, 2560.5775047117204, 2589.2102908612865, 2600.0, 2578.2523068310165, 2580.445204281079, 2582.4705935283223, 2582.6771653543306, 2582.9225123246333, 2436.6466862304956, 2515.9874200629065, 2520.823542352036, 2521.6721826162666, 2522.230719630521, 2533.227365653484, 2586.6508021417058, 2596.195179494344, 2599.181257903754, 2599.233226198276, 2550.744925507453, 2574.201997380799, 2589.805764567665, 2613.9346516337246, 2619.371350875776, 9233.769155771159, 9305.813883722287, 9314.115159059878, 9323.393979391318, 9325.860112098324, 5659.377468478464, 5761.251037365158, 5797.01450753373, 5829.825105246807, 5847.210626565402, 3689.0961714379882, 3765.7740535567677, 3816.313063648542, 3834.7699138051807, 3844.231153769257, 1057.804306203347, 1068.3910171202417, 1075.0432115417284, 1085.0614218700846, 1115.1190559458018, 11390.145739069603, 12318.952889004446, 12529.248245105231, 12542.81185782214, 12592.244465332109, 5070.467600901852, 5072.239164125337, 5159.329287192641, 5190.740462976836, 5247.2653828464045, 10592.735181620366, 10596.205284603531, 10596.682099537025, 10629.202809789296, 10634.521446534924, 5764.827055188351, 5766.135079738073, 5773.278340207474, 5774.422557744276, 5776.393478684678, 4616.653750968623, 4785.353977213102, 5039.874003149951, 5151.0, 5153.639245252872, 3443.328550932544, 4065.6137666921595, 4154.896127596834, 4168.166366726606, 4218.957810421918, 1366.5558693424678, 1385.7020740540631, 1386.050555369575, 1386.3761307411503, 1397.0779285671408, 969.3408482232009, 1166.078797749785, 1169.2283093158474, 1301.5834932821595, 1414.766563517008, 8583.141685831491, 8590.527520986281, 8631.784205394915, 8644.697435589724, 8692.0, 534.6925517827265, 540.1276937745513, 542.2625229687621, 546.3307448375788, 551.1429726774824, 6302.621842689453, 6318.810435686937, 6368.203974503187, 6396.616203027833, 6398.584092034003, 11046.944765276283, 11608.361540115206, 11621.360825154698, 11629.069674426026, 11635.418229088511, 10310.175185985254, 10814.78370432587, 11266.549338026387, 11373.976342129248, 11388.601398950997, 8584.613692383859, 8614.138586141462, 8641.783955401166, 8698.304135669132, 8750.081241469554, 8388.370872184489, 8405.285550728013, 8444.071152173134, 8503.574821259035, 8514.148585141436, 9843.803123937625, 9867.11195992364, 9917.15704165154, 9960.950195248977, 10065.943075976917, 10131.442770647685, 10521.263511554118, 10543.209259305737, 10662.680119596425, 10668.466576671291, 6559.311272316338, 7138.393236574741, 7577.16651168382, 7706.344960678405, 8031.196880311922, 8580.65677372923, 8592.484450932963, 8619.784505387164, 8635.827283454422, 8637.611307491052, 7614.0, 7717.073951125676, 7782.143964163824, 7834.921650783419, 7851.371890248653, 7461.701531938662, 7567.0, 7617.885731714139, 7643.0, 7768.805779855323, 8216.712415065444, 8226.506409615442, 8231.259186673227, 8246.711365102192, 8254.628541715518, 7273.490855640054, 7398.11222653285, 7413.629318534159, 7416.629168541659, 7420.220876808074, 7485.737999170003, 7492.887606686013, 7538.09542854861, 7545.547267163988, 7545.886811697719], "unit": "score", "name": "mootools.html", "value": 5057.594442458767}, {"lowerIsBetter": false, "replicates": [334.4782139861815, 336.9561956945598, 341.7300332737138, 341.92306730985547, 347.383394474807, 5192.766325515351, 6430.839229019277, 6654.534182607219, 6676.332366763321, 6697.229818570866, 6670.132882725251, 6671.799846004627, 6685.164354455693, 6685.431738302238, 6712.993051042346, 4696.976515117437, 4797.520247975192, 4803.591694705954, 4869.366982292315, 4931.975340123303, 4792.209285467894, 4859.514048595148, 4887.6089912807065, 4894.3147959285725, 4899.338589290436, 4860.295257187706, 4879.365682461275, 4884.609231261508, 4902.901941961159, 4910.8281210157475, 4682.953170468286, 4834.854954351357, 4875.8781030474165, 4877.073356062355, 4885.2916327132725, 3495.877644282438, 4118.691098167619, 4184.267753143188, 4238.766867822269, 4253.128108737701, 6436.388543088399, 6449.742010319582, 6454.580452270634, 6458.289588145347, 6470.38531339522, 4985.651004429691, 5857.121431785266, 5857.941420585825, 5859.29688437386, 5873.706314684291, 5726.971365143189, 7123.89314160288, 7124.038254835583, 7128.25153358895, 7131.82170445743, 4453.977730111361, 4612.630989520831, 4754.619630429557, 4763.285507173917, 4771.785269662873, 6468.867948109109, 7175.856482870313, 7366.668499917517, 7511.32398084175, 7520.059992500937, 4707.7175369477945, 4708.576228139484, 4715.504871988392, 4716.528347165325, 4720.504347043579, 3930.4104384342577, 4116.958830411718, 4655.9058621223985, 4795.568398844051, 4827.0, 4606.792694328763, 5698.1737648041635, 5701.800436984686, 5704.743286552115, 5707.942920570824, 6935.271796461399, 7170.677319520634, 7171.278893065627, 7197.280271972761, 7209.6395180241825, 1647.826978167299, 1657.917104144788, 1664.8501634852921, 1671.264643556831, 1672.1639180409795, 1050.9211809114195, 1058.0530425269342, 1067.4876059491487, 1074.3714926767927, 1074.8656417947757, 6341.302456729756, 6451.41937225652, 6507.511936604774, 6543.770968016097, 6638.369354911276, 7469.991551140526, 7501.437392195608, 7504.662290196954, 7511.737089201961, 7516.511426757353, 6632.303608121078, 6633.535652504278, 6634.767783127664, 6636.270010298863, 6641.501887358468, 3901.297766402075, 3943.901402464904, 3948.881533553998, 3950.7234493585174, 3959.3269144245546, 7450.105987281561, 7671.769846904602, 7698.230176982257, 7761.107472640719, 7785.221477852169, 7681.3854891608535, 7714.961425192838, 7717.498362606412, 7738.0, 7740.458167928304, 6991.650417479004, 7757.418193635387, 7788.84422311562, 7792.298693117533, 7796.961015194887, 7211.350978411968, 7477.102747670315, 7493.363064139609, 7501.062367204099, 7504.474686772092, 7324.0, 7359.8160045999275, 7364.926350736424, 7382.741604043833, 7383.372413344711, 6132.693365331626, 7718.729844455417, 7738.264864837832, 7747.070351557849, 7750.224977502205, 4675.883102922454, 4738.715677059387, 4738.834140805193, 4740.19416699155, 4743.620510359094, 5978.730957107027, 7202.991581178744, 7422.109346878409, 7437.8140546486775, 7446.553206807609, 6893.034975103389, 7131.215566287808, 7215.458840586872, 7217.314355136254, 7227.421806255592, 6069.026177173241, 7137.785866424016, 7163.570185788869, 7170.0, 7179.497435179487, 7018.543794653331, 7024.894626580503, 7032.1912980007955, 7049.0, 7067.0, 6849.794506164823, 7088.681009354695, 7151.499395042297, 7177.354038136593, 7179.856402871809, 6696.866062678817, 6859.5541289816, 6871.553349032297, 6993.4055605274125, 7047.0], "unit": "score", "name": "prototype.html", "value": 5184.478532238011}, {"lowerIsBetter": false, "replicates": [765.7281665008918, 793.3177467378054, 794.5034353529045, 803.1446509467416, 805.6012273924408, 15391.153486558249, 15636.84363156371, 15677.059376437423, 15763.290651920648, 15766.369345226192, 13148.539801106963, 14614.050086744353, 14614.926925365358, 14639.560813175622, 14668.779968300458, 981.695674340953, 989.2234595842265, 1001.1190152665644, 1005.1004351105756, 1005.6379703306803, 995.4972738766912, 1000.7548150703052, 1001.0990108901974, 1003.4832061488339, 1004.9598016079348, 1053.399562249518, 1056.9048785609293, 1059.6503153959175, 1060.0565496707936, 1061.8991195836384, 1045.4668119259156, 1049.9737506562321, 1052.3317693264755, 1053.2521909444265, 1053.931494452858, 782.3584660578329, 783.2089589514575, 784.3058892879785, 784.9646765895492, 785.3363907498155, 13644.65888352799, 13688.452461901512, 13716.725665486734, 13731.313434328244, 13874.583762487142, 11601.477933493014, 11652.366730924838, 11659.358735269558, 11921.523139074514, 12022.458989345501, 11144.498497567629, 11189.44052797365, 11258.943705281503, 11440.485178167002, 11505.769884602345, 3483.5471388719557, 3592.8742494012845, 3602.3695853225845, 3639.6542328478754, 3789.5073640426567, 56253.43746562564, 69949.0, 84513.73229401564, 85608.0, 88388.23223535558, 9728.951355243178, 9744.366616169926, 9888.901110988942, 10326.01902819231, 10471.42407167613, 22138.114475421124, 22161.22435714742, 22164.335069947603, 22183.334499965025, 22187.0, 7362.8527429451115, 7514.135874374517, 7803.297703206626, 8064.395170362129, 8126.634301456449, 4124.237016152021, 4151.46031015972, 4193.622573968358, 4217.156568686275, 4237.300845360543, 3750.5311836020496, 3804.0, 3812.4662547243406, 3812.942805857914, 3814.809259537012, 552.0807854921511, 567.5232804444204, 571.2003195526213, 572.5448268626452, 584.9385814489502, 554.5785203245563, 602.4758460139619, 604.7157835817159, 613.0773186354508, 650.0444346810182, 8043.597820108971, 8447.831043379098, 8488.787780305542, 8493.065762766091, 8547.316214702809, 539.463234082083, 559.8572364047142, 596.5347029317139, 615.0712424239431, 620.2928661326092, 3828.291766023239, 3858.6141385861188, 3970.1265721541213, 3973.0266084809405, 4003.799810009488, 98695.0, 99406.5029674847, 100313.0, 100472.4976375128, 102157.446063849, 83505.74741378883, 84943.30113397697, 85003.57498212469, 86255.56872215724, 88202.0, 62349.37650623436, 74087.0, 74363.62818185874, 75280.62359688277, 76003.61998189974, 8370.204830541088, 8657.696980605648, 8739.519326437106, 8805.16350946659, 8970.730878073668, 37300.0, 52476.0, 53026.0, 53306.0, 53756.73121634523, 70912.0, 71044.64477677786, 71353.64323178351, 72841.0, 73417.0, 11137.109031277316, 11339.546418143513, 11596.420178991186, 11619.30284182918, 11658.30050196957, 11968.46141923598, 12196.024318054711, 12385.133040687066, 12437.315947622968, 12493.93753031229, 11921.821172682243, 11928.403579821148, 12081.577144800242, 12128.393580320771, 12246.0, 11548.42257887119, 11803.23278986863, 11834.0, 11953.880461195276, 12079.879201207876, 11705.590304339306, 11764.99997500222, 11872.643820685393, 11951.581694640647, 12312.199707019015, 9806.117449429586, 10132.544035518567, 10158.898411015794, 10402.27184097106, 10457.58169673235, 9483.288753343664, 9774.951125244328, 10039.060164610823, 10078.0, 10112.84830727525], "unit": "score", "name": "yui.html", "value": 7187.312684388654}], "name": "dromaeo_css", "value": 7705.382560690047}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 111.0, 111.0, 113.0, 111.0, 121.0, 112.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [152.0, 120.0, 137.0, 156.0, 118.0, 138.0, 120.0, 137.0, 166.0, 99.0], "unit": "score", "name": "audio-beat-detection", "value": 134.3}, {"lowerIsBetter": true, "replicates": [184.0, 186.0, 183.0, 186.0, 188.0, 187.0, 186.0, 185.0, 185.0, 184.0], "unit": "score", "name": "audio-dft", "value": 185.4}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 72.0, 121.0, 55.0, 57.0, 57.0, 58.0, 125.0, 78.0], "unit": "score", "name": "audio-fft", "value": 77.2}, {"lowerIsBetter": true, "replicates": [90.0, 95.0, 130.0, 80.0, 79.0, 89.0, 115.0, 76.0, 78.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 94.8}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 86.0, 83.0, 86.0, 84.0, 86.0, 84.0, 90.0, 129.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 89.8}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 93.0, 93.0, 92.0, 92.0, 92.0, 93.0, 107.0, 150.0], "unit": "score", "name": "imaging-darkroom", "value": 99.7}, {"lowerIsBetter": true, "replicates": [87.0, 88.0, 85.0, 86.0, 87.0, 87.0, 87.0, 87.0, 85.0, 89.0], "unit": "score", "name": "imaging-desaturate", "value": 86.8}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 55.0, 59.0, 83.0, 89.0, 79.0, 67.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 64.9}, {"lowerIsBetter": true, "replicates": [62.0, 61.0, 72.0, 75.0, 70.0, 66.0, 66.0, 66.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [78.0, 80.0, 81.0, 77.0, 81.0, 80.0, 78.0, 80.0, 79.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.8}, {"lowerIsBetter": true, "replicates": [123.0, 124.0, 127.0, 117.0, 119.0, 128.0, 114.0, 114.0, 108.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.0}, {"lowerIsBetter": true, "replicates": [132.0, 132.0, 134.0, 131.0, 132.0, 132.0, 133.0, 132.0, 133.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 132.2}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 66.0, 66.0, 67.0, 66.0, 68.0, 77.0, 96.0, 96.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 73.3}], "name": "kraken", "value": 1416.5}]} 03:16:17 INFO - Return code: 0 03:16:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:16:17 INFO - # TBPL SUCCESS # 03:16:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:16:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:16:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:16:17 INFO - 2016-03-15 03:16:17.379 screenresolution[1680:9862] starting screenresolution argv=screenresolution get 03:16:17 INFO - 2016-03-15 03:16:17.381 screenresolution[1680:9862] Display 0: 1600x1200x32@60 03:16:17 INFO - 2016-03-15 03:16:17.387 screenresolution[1681:9865] starting screenresolution argv=screenresolution list 03:16:17 INFO - Available Modes on Display 0 03:16:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:16:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:16:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:16:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:16:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:16:17 INFO - Intel Iris: 03:16:17 INFO - Chipset Model: Intel Iris 03:16:17 INFO - Type: GPU 03:16:17 INFO - Bus: Built-In 03:16:17 INFO - VRAM (Dynamic, Max): 1536 MB 03:16:17 INFO - Vendor: Intel (0x8086) 03:16:17 INFO - Device ID: 0x0a2e 03:16:17 INFO - Revision ID: 0x0009 03:16:17 INFO - Displays: 03:16:17 INFO - Display: 03:16:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:16:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:16:17 INFO - Display Serial Number: 1600x1200 60 03:16:17 INFO - Main Display: Yes 03:16:17 INFO - Mirror: Off 03:16:17 INFO - Online: Yes 03:16:17 INFO - Rotation: Supported 03:16:17 INFO - Return code: 0 03:16:17 INFO - Running post-action listener: _resource_record_post_action 03:16:17 INFO - Running post-run listener: _resource_record_post_run 03:16:18 INFO - Total resource usage - Wall time: 1203s; CPU: 52.0%; Read bytes: 31907328; Write bytes: 664566784; Read time: 325; Write time: 2052 03:16:18 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 358003200; Write bytes: 353662464; Read time: 28323; Write time: 681 03:16:18 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 30125568; Write bytes: 299730432; Read time: 308; Write time: 1336 03:16:18 INFO - Running post-run listener: _upload_blobber_files 03:16:18 INFO - Blob upload gear active. 03:16:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:16:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:16:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:16:19 INFO - (blobuploader) - INFO - Open directory for files ... 03:16:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:16:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:16:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:20 INFO - (blobuploader) - INFO - Done attempting. 03:16:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:16:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:16:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:21 INFO - (blobuploader) - INFO - Done attempting. 03:16:21 INFO - (blobuploader) - INFO - Iteration through files over. 03:16:21 INFO - Return code: 0 03:16:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:16:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:16:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26ff1d05260aeede7974aac4c70e666507c2f695f0b05b1abd4eaafb83b31064984907be1f7e45132584bce8c8c6c5a67b851bc942229e06412f20f0fd4c035a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1e9cb8494979dbcab1633e0cab72d20d9aa52f49093bb866b8ef6bf42c0d711d8f7be84f1414d46b3f52d5acfc0f66eaeaf179a7849d6d949c945e3a1ac2ca02"} 03:16:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:16:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:16:21 INFO - Contents: 03:16:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26ff1d05260aeede7974aac4c70e666507c2f695f0b05b1abd4eaafb83b31064984907be1f7e45132584bce8c8c6c5a67b851bc942229e06412f20f0fd4c035a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1e9cb8494979dbcab1633e0cab72d20d9aa52f49093bb866b8ef6bf42c0d711d8f7be84f1414d46b3f52d5acfc0f66eaeaf179a7849d6d949c945e3a1ac2ca02"} 03:16:21 INFO - Running post-run listener: copy_logs_to_upload_dir 03:16:21 INFO - Copying logs to upload dir... 03:16:21 INFO - mkdir: /builds/slave/test/build/upload/logs 03:16:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.891473 ========= master_lag: 2.99 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-15 03:16:24.221770) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 03:16:24.230239) ========= 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.zH0CBgkELQ/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.3zhLlDnhVs/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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/26ff1d05260aeede7974aac4c70e666507c2f695f0b05b1abd4eaafb83b31064984907be1f7e45132584bce8c8c6c5a67b851bc942229e06412f20f0fd4c035a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1e9cb8494979dbcab1633e0cab72d20d9aa52f49093bb866b8ef6bf42c0d711d8f7be84f1414d46b3f52d5acfc0f66eaeaf179a7849d6d949c945e3a1ac2ca02"} build_url:https://queue.taskcluster.net/v1/task/YflO_E2ZTW6ERBJGCKNU6w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011020 build_url: 'https://queue.taskcluster.net/v1/task/YflO_E2ZTW6ERBJGCKNU6w/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/26ff1d05260aeede7974aac4c70e666507c2f695f0b05b1abd4eaafb83b31064984907be1f7e45132584bce8c8c6c5a67b851bc942229e06412f20f0fd4c035a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1e9cb8494979dbcab1633e0cab72d20d9aa52f49093bb866b8ef6bf42c0d711d8f7be84f1414d46b3f52d5acfc0f66eaeaf179a7849d6d949c945e3a1ac2ca02"}' ========= master_lag: 0.82 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 03:16:25.065733) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 03:16:25.070346) ========= 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.zH0CBgkELQ/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.3zhLlDnhVs/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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.004996 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 03:16:25.098488) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 03:16:25.098806) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 03:16:25.099954) ========= ========= Total master_lag: 20.26 =========