builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0032 starttime: 1458681128.07 results: success (0) buildid: 20160322123449 builduid: bf80d8caf47d41588890a95a08b82d97 revision: b60392ce5fb443b3629e95037d6e2e299f3ee08e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-22 14:12:08.070998) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-22 14:12:08.075815) ========= ========= Started set props: basedir (results: 0, elapsed: 7 secs) (at 2016-03-22 14:12:08.076104) ========= 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.C0VbIPbPfw/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.yFkNcc8kxp/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.005385 basedir: '/builds/slave/test' ========= master_lag: 7.83 ========= ========= Finished set props: basedir (results: 0, elapsed: 7 secs) (at 2016-03-22 14:12:15.907470) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 5 secs) (at 2016-03-22 14:12:15.907793) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 5 secs) (at 2016-03-22 14:12:21.882014) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 14:12:21.882375) ========= 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.C0VbIPbPfw/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.yFkNcc8kxp/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.006126 ========= master_lag: 0.58 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 14:12:22.466614) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-22 14:12:22.466880) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-22 14:12:22.467220) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-03-22 14:12:22.467501) ========= 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.C0VbIPbPfw/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.yFkNcc8kxp/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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-22 14:12:22-- 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% 8.85M=0.001s 2016-03-22 14:12:22 (8.85 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.323627 ========= master_lag: 3.94 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-03-22 14:12:26.735865) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 14:12:26.736259) ========= 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.C0VbIPbPfw/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.yFkNcc8kxp/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.026800 ========= master_lag: 0.56 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 14:12:27.326932) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-03-22 14:12:27.327284) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b60392ce5fb443b3629e95037d6e2e299f3ee08e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b60392ce5fb443b3629e95037d6e2e299f3ee08e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.C0VbIPbPfw/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.yFkNcc8kxp/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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-22 14:12:27,565 truncating revision to first 12 chars 2016-03-22 14:12:27,565 Setting DEBUG logging. 2016-03-22 14:12:27,565 attempt 1/10 2016-03-22 14:12:27,565 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b60392ce5fb4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-22 14:12:29,417 unpacking tar archive at: fx-team-b60392ce5fb4/testing/mozharness/ program finished with exit code 0 elapsedTime=2.097988 ========= master_lag: 1.60 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-03-22 14:12:31.028377) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-03-22 14:12:31.032725) ========= echo b60392ce5fb443b3629e95037d6e2e299f3ee08e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b60392ce5fb443b3629e95037d6e2e299f3ee08e'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.C0VbIPbPfw/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.yFkNcc8kxp/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 b60392ce5fb443b3629e95037d6e2e299f3ee08e program finished with exit code 0 elapsedTime=0.005765 script_repo_revision: 'b60392ce5fb443b3629e95037d6e2e299f3ee08e' ========= master_lag: 1.12 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-03-22 14:12:32.160391) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 3 secs) (at 2016-03-22 14:12:32.160859) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 3 secs) (at 2016-03-22 14:12:35.321214) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 47 secs) (at 2016-03-22 14:12:35.324490) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.C0VbIPbPfw/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.yFkNcc8kxp/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:12:35 INFO - MultiFileLogger online at 20160322 14:12:35 in /builds/slave/test 14:12:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:12:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:12:35 INFO - {'append_to_log': False, 14:12:35 INFO - 'base_work_dir': '/builds/slave/test', 14:12:35 INFO - 'blob_upload_branch': 'Fx-Team', 14:12:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:12:35 INFO - 'branch': 'Fx-Team', 14:12:35 INFO - 'buildbot_json_path': 'buildprops.json', 14:12:35 INFO - 'config_files': ('talos/mac_config.py',), 14:12:35 INFO - 'default_actions': ('clobber', 14:12:35 INFO - 'read-buildbot-config', 14:12:35 INFO - 'download-and-extract', 14:12:35 INFO - 'populate-webroot', 14:12:35 INFO - 'create-virtualenv', 14:12:35 INFO - 'install', 14:12:35 INFO - 'run-tests'), 14:12:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:12:35 INFO - 'download_minidump_stackwalk': True, 14:12:35 INFO - 'download_symbols': 'ondemand', 14:12:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:12:35 INFO - 'tooltool.py': '/tools/tooltool.py', 14:12:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:12:35 INFO - '/tools/misc-python/virtualenv.py')}, 14:12:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:12:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:12:35 INFO - 'installer_path': 'installer.exe', 14:12:35 INFO - 'log_level': 'info', 14:12:35 INFO - 'log_name': 'talos', 14:12:35 INFO - 'log_to_console': True, 14:12:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:12:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:12:35 INFO - 'opt_config_files': (), 14:12:35 INFO - 'pip_index': False, 14:12:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:12:35 INFO - 'cmd': ('bash', 14:12:35 INFO - '-c', 14:12:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:12:35 INFO - 'enabled': True, 14:12:35 INFO - 'halt_on_failure': False, 14:12:35 INFO - 'name': 'check_screen_resolution'},), 14:12:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:12:35 INFO - 'cmd': ('bash', 14:12:35 INFO - '-c', 14:12:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:12:35 INFO - 'enabled': True, 14:12:35 INFO - 'halt_on_failure': False, 14:12:35 INFO - 'name': 'check_screen_resolution'},), 14:12:35 INFO - 'run_cmd_checks_enabled': True, 14:12:35 INFO - 'sps_profile': False, 14:12:35 INFO - 'sps_profile_interval': 0, 14:12:35 INFO - 'suite': 'dromaeojs', 14:12:35 INFO - 'system_bits': '32', 14:12:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:12:35 INFO - 'title': 't-yosemite-r7-0032', 14:12:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:12:35 INFO - 'use_talos_json': True, 14:12:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:12:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:12:35 INFO - 'work_dir': 'build'} 14:12:35 INFO - ##### 14:12:35 INFO - ##### Running clobber step. 14:12:35 INFO - ##### 14:12:35 INFO - Running pre-action listener: _resource_record_pre_action 14:12:35 INFO - Running main action method: clobber 14:12:35 INFO - rmtree: /builds/slave/test/build 14:12:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:12:37 INFO - Running post-action listener: _resource_record_post_action 14:12:37 INFO - ##### 14:12:37 INFO - ##### Running read-buildbot-config step. 14:12:37 INFO - ##### 14:12:37 INFO - Running pre-action listener: _resource_record_pre_action 14:12:37 INFO - Running main action method: read_buildbot_config 14:12:37 INFO - Using buildbot properties: 14:12:37 INFO - { 14:12:37 INFO - "project": "", 14:12:37 INFO - "product": "firefox", 14:12:37 INFO - "script_repo_revision": "production", 14:12:37 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 14:12:37 INFO - "repository": "", 14:12:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 14:12:37 INFO - "buildid": "20160322123449", 14:12:37 INFO - "pgo_build": "False", 14:12:37 INFO - "basedir": "/builds/slave/test", 14:12:37 INFO - "buildnumber": 608, 14:12:37 INFO - "slavename": "t-yosemite-r7-0032", 14:12:37 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 14:12:37 INFO - "platform": "yosemite_r7", 14:12:37 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:12:37 INFO - "branch": "fx-team", 14:12:37 INFO - "repo_path": "integration/fx-team", 14:12:37 INFO - "revision": "b60392ce5fb443b3629e95037d6e2e299f3ee08e", 14:12:37 INFO - "stage_platform": "macosx64", 14:12:37 INFO - "builduid": "bf80d8caf47d41588890a95a08b82d97", 14:12:37 INFO - "slavebuilddir": "test" 14:12:37 INFO - } 14:12:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 14:12:37 INFO - Running post-action listener: _resource_record_post_action 14:12:37 INFO - ##### 14:12:37 INFO - ##### Running download-and-extract step. 14:12:37 INFO - ##### 14:12:37 INFO - Running pre-action listener: _resource_record_pre_action 14:12:37 INFO - Running main action method: download_and_extract 14:12:37 INFO - mkdir: /builds/slave/test/build/tests 14:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:37 INFO - https://queue.taskcluster.net/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:12:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 14:12:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 14:12:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 14:12:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 14:12:40 INFO - Downloaded 1199 bytes. 14:12:40 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 14:12:40 INFO - Using the following test package requirements: 14:12:40 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 14:12:40 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:12:40 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 14:12:40 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:12:40 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 14:12:40 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:12:40 INFO - u'jsshell-mac.zip'], 14:12:40 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:12:40 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 14:12:40 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 14:12:40 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:12:40 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 14:12:40 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:12:40 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 14:12:40 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:12:40 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 14:12:40 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:12:40 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 14:12:40 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:40 INFO - https://queue.taskcluster.net/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:12:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:12:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:12:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:12:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:12:50 INFO - Downloaded 17860515 bytes. 14:12:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:12:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:12:53 INFO - Return code: 0 14:12:53 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:53 INFO - https://queue.taskcluster.net/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:12:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:12:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:12:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:12:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:13:02 INFO - Downloaded 17860515 bytes. 14:13:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:13:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:13:06 INFO - Return code: 0 14:13:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:13:06 INFO - https://queue.taskcluster.net/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:13:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:13:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:13:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:13:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:13:19 INFO - Downloaded 10848120 bytes. 14:13:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:13:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:13:20 INFO - Return code: 0 14:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:13:20 INFO - https://queue.taskcluster.net/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:13:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:13:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:13:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 14:13:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 14:13:55 INFO - Downloaded 111273961 bytes. 14:13:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:13:55 INFO - mkdir: /builds/slave/test/properties 14:13:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:13:55 INFO - Writing to file /builds/slave/test/properties/build_url 14:13:55 INFO - Contents: 14:13:55 INFO - build_url:https://queue.taskcluster.net/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:13:58 INFO - Running post-action listener: _resource_record_post_action 14:13:58 INFO - Running post-action listener: set_extra_try_arguments 14:13:58 INFO - ##### 14:13:58 INFO - ##### Running populate-webroot step. 14:13:58 INFO - ##### 14:13:58 INFO - Running pre-action listener: _resource_record_pre_action 14:13:58 INFO - Running main action method: populate_webroot 14:13:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:13:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:13:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:13:58 INFO - '--tppagecycles', 14:13:58 INFO - '7'], 14:13:58 INFO - 'tests': ['tsvgm']}}, 14:13:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:13:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:13:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:13:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:13:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:13:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:13:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:13:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:58 INFO - 'talos_options': ['--e10s'], 14:13:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:13:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:58 INFO - 'tests': ['damp', 'tps']}, 14:13:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:58 INFO - 'talos_options': ['--e10s'], 14:13:58 INFO - 'tests': ['damp', 'tps']}, 14:13:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:13:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:13:58 INFO - 'other': {'tests': ['a11yr', 14:13:58 INFO - 'ts_paint', 14:13:58 INFO - 'tpaint', 14:13:58 INFO - 'sessionrestore', 14:13:58 INFO - 'sessionrestore_no_auto_restore', 14:13:58 INFO - 'tabpaint']}, 14:13:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:13:58 INFO - 'tests': ['a11yr', 14:13:58 INFO - 'ts_paint', 14:13:58 INFO - 'tpaint', 14:13:58 INFO - 'sessionrestore', 14:13:58 INFO - 'sessionrestore_no_auto_restore', 14:13:58 INFO - 'tabpaint']}, 14:13:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:13:58 INFO - 'tests': ['a11yr', 14:13:58 INFO - 'ts_paint', 14:13:58 INFO - 'tpaint', 14:13:58 INFO - 'sessionrestore', 14:13:58 INFO - 'sessionrestore_no_auto_restore', 14:13:58 INFO - 'tabpaint']}, 14:13:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:13:58 INFO - 'tests': ['a11yr', 14:13:58 INFO - 'ts_paint', 14:13:58 INFO - 'tpaint', 14:13:58 INFO - 'sessionrestore', 14:13:58 INFO - 'sessionrestore_no_auto_restore', 14:13:58 INFO - 'tabpaint']}, 14:13:58 INFO - 'other_l64': {'tests': ['a11yr', 14:13:58 INFO - 'ts_paint', 14:13:58 INFO - 'tpaint', 14:13:58 INFO - 'sessionrestore', 14:13:58 INFO - 'sessionrestore_no_auto_restore', 14:13:58 INFO - 'tabpaint']}, 14:13:58 INFO - 'other_nol64': {'tests': ['a11yr', 14:13:58 INFO - 'ts_paint', 14:13:58 INFO - 'tpaint', 14:13:58 INFO - 'sessionrestore', 14:13:58 INFO - 'sessionrestore_no_auto_restore', 14:13:58 INFO - 'tabpaint']}, 14:13:58 INFO - 'svgr': {'tests': ['tsvgx', 14:13:58 INFO - 'tsvgr_opacity', 14:13:58 INFO - 'tart', 14:13:58 INFO - 'tscrollx', 14:13:58 INFO - 'cart']}, 14:13:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:13:58 INFO - 'tests': ['tsvgx', 14:13:58 INFO - 'tsvgr_opacity', 14:13:58 INFO - 'tart', 14:13:58 INFO - 'tscrollx', 14:13:58 INFO - 'cart']}, 14:13:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:58 INFO - 'tests': ['tp5o']}, 14:13:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:58 INFO - 'talos_options': ['--e10s'], 14:13:58 INFO - 'tests': ['tp5o']}, 14:13:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:58 INFO - 'talos_options': ['--xperf_path', 14:13:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:13:58 INFO - 'tests': ['tp5n']}, 14:13:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:58 INFO - 'talos_options': ['--e10s', 14:13:58 INFO - '--xperf_path', 14:13:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:13:58 INFO - 'tests': ['tp5n']}}, 14:13:58 INFO - 'talos.zip': {'path': '', 14:13:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:13:58 INFO - Running post-action listener: _resource_record_post_action 14:13:58 INFO - ##### 14:13:58 INFO - ##### Running create-virtualenv step. 14:13:58 INFO - ##### 14:13:58 INFO - Running pre-action listener: _resource_record_pre_action 14:13:58 INFO - Running main action method: create_virtualenv 14:13:58 INFO - Creating virtualenv /builds/slave/test/build/venv 14:13:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:13:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:13:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:13:58 INFO - Using real prefix '/tools/python27' 14:13:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:13:59 INFO - Installing distribute.............................................................................................................................................................................................done. 14:14:01 INFO - Installing pip.................done. 14:14:01 INFO - Return code: 0 14:14:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:02 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 0x107e93a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea33c99120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d32e00>, '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 0x107b5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d2db20>, '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.C0VbIPbPfw/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.yFkNcc8kxp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:14:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:14:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:14:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C0VbIPbPfw/Render', 14:14:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:02 INFO - 'HOME': '/Users/cltbld', 14:14:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:02 INFO - 'LOGNAME': 'cltbld', 14:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:02 INFO - 'MOZ_NO_REMOTE': '1', 14:14:02 INFO - 'NO_EM_RESTART': '1', 14:14:02 INFO - 'PAGER': '/bin/cat', 14:14:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:02 INFO - 'PWD': '/builds/slave/test', 14:14:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:02 INFO - 'SHELL': '/bin/bash', 14:14:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yFkNcc8kxp/Listeners', 14:14:02 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 14:14:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:02 INFO - 'USER': 'cltbld', 14:14:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:02 INFO - 'XPC_FLAGS': '0x0', 14:14:02 INFO - 'XPC_SERVICE_NAME': '0', 14:14:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:14:02 INFO - Cleaning up... 14:14:02 INFO - Return code: 0 14:14:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:02 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 0x107e93a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea33c99120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d32e00>, '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 0x107b5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d2db20>, '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.C0VbIPbPfw/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.yFkNcc8kxp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:14:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:14:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:14:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C0VbIPbPfw/Render', 14:14:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:02 INFO - 'HOME': '/Users/cltbld', 14:14:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:02 INFO - 'LOGNAME': 'cltbld', 14:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:02 INFO - 'MOZ_NO_REMOTE': '1', 14:14:02 INFO - 'NO_EM_RESTART': '1', 14:14:02 INFO - 'PAGER': '/bin/cat', 14:14:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:02 INFO - 'PWD': '/builds/slave/test', 14:14:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:02 INFO - 'SHELL': '/bin/bash', 14:14:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yFkNcc8kxp/Listeners', 14:14:02 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 14:14:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:02 INFO - 'USER': 'cltbld', 14:14:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:02 INFO - 'XPC_FLAGS': '0x0', 14:14:02 INFO - 'XPC_SERVICE_NAME': '0', 14:14:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:02 INFO - Downloading/unpacking psutil>=0.7.1 14:14: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 14:14: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 14:14: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 14:14: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 14:14: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 14:14: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 14:14:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:14:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:14:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:14:15 INFO - Installing collected packages: psutil 14:14:15 INFO - Running setup.py install for psutil 14:14:15 INFO - building 'psutil._psutil_osx' extension 14:14:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:14:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:14:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:14:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:14:15 INFO - building 'psutil._psutil_posix' extension 14:14:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:14:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:14:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:14:15 INFO - ^ 14:14:16 INFO - 1 warning generated. 14:14:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:14:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:14:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:14:16 INFO - Successfully installed psutil 14:14:16 INFO - Cleaning up... 14:14:16 INFO - Return code: 0 14:14:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:16 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 0x107e93a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea33c99120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d32e00>, '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 0x107b5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d2db20>, '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.C0VbIPbPfw/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.yFkNcc8kxp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:14:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:14:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C0VbIPbPfw/Render', 14:14:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:16 INFO - 'HOME': '/Users/cltbld', 14:14:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:16 INFO - 'LOGNAME': 'cltbld', 14:14:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:16 INFO - 'MOZ_NO_REMOTE': '1', 14:14:16 INFO - 'NO_EM_RESTART': '1', 14:14:16 INFO - 'PAGER': '/bin/cat', 14:14:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:16 INFO - 'PWD': '/builds/slave/test', 14:14:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:16 INFO - 'SHELL': '/bin/bash', 14:14:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yFkNcc8kxp/Listeners', 14:14:16 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 14:14:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:16 INFO - 'USER': 'cltbld', 14:14:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:16 INFO - 'XPC_FLAGS': '0x0', 14:14:16 INFO - 'XPC_SERVICE_NAME': '0', 14:14:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:14:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:14:23 INFO - Installing collected packages: mozsystemmonitor 14:14:23 INFO - Running setup.py install for mozsystemmonitor 14:14:24 INFO - Successfully installed mozsystemmonitor 14:14:24 INFO - Cleaning up... 14:14:24 INFO - Return code: 0 14:14:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:14: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')]} 14:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14: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')]} 14:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:24 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 0x107e93a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea33c99120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d32e00>, '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 0x107b5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d2db20>, '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.C0VbIPbPfw/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.yFkNcc8kxp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:14:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:14:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C0VbIPbPfw/Render', 14:14:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:24 INFO - 'HOME': '/Users/cltbld', 14:14:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:24 INFO - 'LOGNAME': 'cltbld', 14:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:24 INFO - 'MOZ_NO_REMOTE': '1', 14:14:24 INFO - 'NO_EM_RESTART': '1', 14:14:24 INFO - 'PAGER': '/bin/cat', 14:14:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:24 INFO - 'PWD': '/builds/slave/test', 14:14:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:24 INFO - 'SHELL': '/bin/bash', 14:14:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yFkNcc8kxp/Listeners', 14:14:24 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 14:14:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:24 INFO - 'USER': 'cltbld', 14:14:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:24 INFO - 'XPC_FLAGS': '0x0', 14:14:24 INFO - 'XPC_SERVICE_NAME': '0', 14:14:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:24 INFO - Downloading/unpacking blobuploader==1.2.4 14:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:30 INFO - Downloading blobuploader-1.2.4.tar.gz 14:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:14:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:14:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:33 INFO - Downloading docopt-0.6.1.tar.gz 14:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:14:33 INFO - Installing collected packages: blobuploader, requests, docopt 14:14:33 INFO - Running setup.py install for blobuploader 14:14:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:14:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:14:33 INFO - Running setup.py install for requests 14:14:34 INFO - Running setup.py install for docopt 14:14:34 INFO - Successfully installed blobuploader requests docopt 14:14:34 INFO - Cleaning up... 14:14:34 INFO - Return code: 0 14:14:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:34 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 0x107e93a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea33c99120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d32e00>, '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 0x107b5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d2db20>, '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.C0VbIPbPfw/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.yFkNcc8kxp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:14:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:14:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C0VbIPbPfw/Render', 14:14:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:34 INFO - 'HOME': '/Users/cltbld', 14:14:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:34 INFO - 'LOGNAME': 'cltbld', 14:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:34 INFO - 'MOZ_NO_REMOTE': '1', 14:14:34 INFO - 'NO_EM_RESTART': '1', 14:14:34 INFO - 'PAGER': '/bin/cat', 14:14:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:34 INFO - 'PWD': '/builds/slave/test', 14:14:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:34 INFO - 'SHELL': '/bin/bash', 14:14:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yFkNcc8kxp/Listeners', 14:14:34 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 14:14:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:34 INFO - 'USER': 'cltbld', 14:14:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:34 INFO - 'XPC_FLAGS': '0x0', 14:14:34 INFO - 'XPC_SERVICE_NAME': '0', 14:14:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:14:34 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-CLDnur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:14:34 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-LuC4Cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:14:34 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-oWK6kL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:14:34 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-uEEuA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:14:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-M4IFI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:14:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-wS9Gf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:14:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-rdPcAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:14:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-kCXfe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:14:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-sUL8NY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:14:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-kH2bMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:14:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-P8ELg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:14:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-B6uIbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:14:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-vvosM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:14:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-TEDijk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:14:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-y_QsJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:14:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-u9lsCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:14:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-BLRb6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:14:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:14:36 INFO - Running setup.py install for manifestparser 14:14:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:14:36 INFO - Running setup.py install for mozcrash 14:14:36 INFO - Running setup.py install for mozdebug 14:14:36 INFO - Running setup.py install for mozdevice 14:14:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:14:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:14:36 INFO - Running setup.py install for mozfile 14:14:37 INFO - Running setup.py install for mozhttpd 14:14:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:14:37 INFO - Running setup.py install for mozinfo 14:14:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:14:37 INFO - Running setup.py install for mozInstall 14:14:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:14:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:14:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:14:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:14:37 INFO - Running setup.py install for mozleak 14:14:37 INFO - Running setup.py install for mozlog 14:14:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:14:37 INFO - Running setup.py install for moznetwork 14:14:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:14:37 INFO - Running setup.py install for mozprocess 14:14:38 INFO - Running setup.py install for mozprofile 14:14:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:14:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:14:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:14:38 INFO - Running setup.py install for mozrunner 14:14:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:14:38 INFO - Running setup.py install for mozscreenshot 14:14:38 INFO - Running setup.py install for moztest 14:14:38 INFO - Running setup.py install for mozversion 14:14:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:14:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:14:38 INFO - Cleaning up... 14:14:38 INFO - Return code: 0 14:14:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:38 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 0x107e93a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea33c99120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d32e00>, '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 0x107b5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d2db20>, '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.C0VbIPbPfw/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.yFkNcc8kxp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:14:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:14:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C0VbIPbPfw/Render', 14:14:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:38 INFO - 'HOME': '/Users/cltbld', 14:14:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:38 INFO - 'LOGNAME': 'cltbld', 14:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:38 INFO - 'MOZ_NO_REMOTE': '1', 14:14:38 INFO - 'NO_EM_RESTART': '1', 14:14:38 INFO - 'PAGER': '/bin/cat', 14:14:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:38 INFO - 'PWD': '/builds/slave/test', 14:14:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:38 INFO - 'SHELL': '/bin/bash', 14:14:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yFkNcc8kxp/Listeners', 14:14:38 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 14:14:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:38 INFO - 'USER': 'cltbld', 14:14:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:38 INFO - 'XPC_FLAGS': '0x0', 14:14:38 INFO - 'XPC_SERVICE_NAME': '0', 14:14:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:14:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-A9OzJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:14:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-KIOlCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:14:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-cIaCti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:14:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-TcPdOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:14:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-7qR6YF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:14:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-lSgWGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:14:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-p1fKUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:14:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-iLc5yf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:14:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-cJKapD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:14:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-SnSeLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:14:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-STCEY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:14:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-fVhoSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:14:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Q4TjUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:14:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-mna9hY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:14:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-SXIAIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:14:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-RBOWIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:14:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-5sQ81e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:14:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:48 INFO - Downloading blessings-1.6.tar.gz 14:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:14:48 INFO - Installing collected packages: blessings 14:14:48 INFO - Running setup.py install for blessings 14:14:48 INFO - Successfully installed blessings 14:14:48 INFO - Cleaning up... 14:14:48 INFO - Return code: 0 14:14:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:14:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:14:48 INFO - Reading from file tmpfile_stdout 14:14:48 INFO - Current package versions: 14:14:48 INFO - blessings == 1.6 14:14:48 INFO - blobuploader == 1.2.4 14:14:48 INFO - docopt == 0.6.1 14:14:48 INFO - manifestparser == 1.1 14:14:48 INFO - mozInstall == 1.12 14:14:48 INFO - mozcrash == 0.17 14:14:48 INFO - mozdebug == 0.1 14:14:48 INFO - mozdevice == 0.48 14:14:48 INFO - mozfile == 1.2 14:14:48 INFO - mozhttpd == 0.7 14:14:48 INFO - mozinfo == 0.9 14:14:48 INFO - mozleak == 0.1 14:14:48 INFO - mozlog == 3.1 14:14:48 INFO - moznetwork == 0.27 14:14:48 INFO - mozprocess == 0.22 14:14:48 INFO - mozprofile == 0.28 14:14:48 INFO - mozrunner == 6.11 14:14:48 INFO - mozscreenshot == 0.1 14:14:48 INFO - mozsystemmonitor == 0.0 14:14:48 INFO - moztest == 0.7 14:14:48 INFO - mozversion == 1.4 14:14:48 INFO - psutil == 3.1.1 14:14:48 INFO - requests == 1.2.3 14:14:48 INFO - wsgiref == 0.1.2 14:14:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:14: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')]} 14:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14: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')]} 14:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:48 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 0x107e93a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea33c99120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d32e00>, '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 0x107b5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d2db20>, '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.C0VbIPbPfw/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.yFkNcc8kxp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:14:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:14:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C0VbIPbPfw/Render', 14:14:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:48 INFO - 'HOME': '/Users/cltbld', 14:14:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:48 INFO - 'LOGNAME': 'cltbld', 14:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:48 INFO - 'MOZ_NO_REMOTE': '1', 14:14:48 INFO - 'NO_EM_RESTART': '1', 14:14:48 INFO - 'PAGER': '/bin/cat', 14:14:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:48 INFO - 'PWD': '/builds/slave/test', 14:14:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:48 INFO - 'SHELL': '/bin/bash', 14:14:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yFkNcc8kxp/Listeners', 14:14:48 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 14:14:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:48 INFO - 'USER': 'cltbld', 14:14:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:48 INFO - 'XPC_FLAGS': '0x0', 14:14:48 INFO - 'XPC_SERVICE_NAME': '0', 14:14:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:14:49 INFO - Cleaning up... 14:14:49 INFO - Return code: 0 14:14:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e93a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea33c99120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d32e00>, '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 0x107b5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d2db20>, '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.C0VbIPbPfw/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.yFkNcc8kxp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:14:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:14:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C0VbIPbPfw/Render', 14:14:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:49 INFO - 'HOME': '/Users/cltbld', 14:14:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:49 INFO - 'LOGNAME': 'cltbld', 14:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:49 INFO - 'MOZ_NO_REMOTE': '1', 14:14:49 INFO - 'NO_EM_RESTART': '1', 14:14:49 INFO - 'PAGER': '/bin/cat', 14:14:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:49 INFO - 'PWD': '/builds/slave/test', 14:14:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:49 INFO - 'SHELL': '/bin/bash', 14:14:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yFkNcc8kxp/Listeners', 14:14:49 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 14:14:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:49 INFO - 'USER': 'cltbld', 14:14:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:49 INFO - 'XPC_FLAGS': '0x0', 14:14:49 INFO - 'XPC_SERVICE_NAME': '0', 14:14:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:49 INFO - Downloading/unpacking jsonschema 14:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:14:55 INFO - Downloading/unpacking functools32 (from jsonschema) 14:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:55 INFO - Downloading functools32-3.2.3-2.tar.gz 14:14:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:14:55 INFO - warning: no files found matching '*.txt' 14:14:55 INFO - no previously-included directories found matching 'build' 14:14:55 INFO - no previously-included directories found matching 'dist' 14:14:55 INFO - no previously-included directories found matching '.git*' 14:14:55 INFO - Installing collected packages: jsonschema, functools32 14:14:55 INFO - Running setup.py install for functools32 14:14:56 INFO - warning: no files found matching '*.txt' 14:14:56 INFO - no previously-included directories found matching 'build' 14:14:56 INFO - no previously-included directories found matching 'dist' 14:14:56 INFO - no previously-included directories found matching '.git*' 14:14:56 INFO - Successfully installed jsonschema functools32 14:14:56 INFO - Cleaning up... 14:14:56 INFO - Return code: 0 14:14:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e93a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea33c99120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d32e00>, '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 0x107b5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d2db20>, '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.C0VbIPbPfw/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.yFkNcc8kxp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:14:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:14:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:14:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C0VbIPbPfw/Render', 14:14:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:56 INFO - 'HOME': '/Users/cltbld', 14:14:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:56 INFO - 'LOGNAME': 'cltbld', 14:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:56 INFO - 'MOZ_NO_REMOTE': '1', 14:14:56 INFO - 'NO_EM_RESTART': '1', 14:14:56 INFO - 'PAGER': '/bin/cat', 14:14:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:56 INFO - 'PWD': '/builds/slave/test', 14:14:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:56 INFO - 'SHELL': '/bin/bash', 14:14:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yFkNcc8kxp/Listeners', 14:14:56 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 14:14:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:56 INFO - 'USER': 'cltbld', 14:14:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:56 INFO - 'XPC_FLAGS': '0x0', 14:14:56 INFO - 'XPC_SERVICE_NAME': '0', 14:14:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:56 INFO - Downloading/unpacking flake8 14:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:15:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:15:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:15:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:15:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:15:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:15:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:15:05 INFO - no previously-included directories found matching 'docs/_build' 14:15:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:15:05 INFO - Running setup.py install for pep8 14:15:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:15:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:15:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:15:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:15:05 INFO - no previously-included directories found matching 'docs/_build' 14:15:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:15:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:15:05 INFO - Cleaning up... 14:15:05 INFO - Return code: 0 14:15:05 INFO - Running post-action listener: _resource_record_post_action 14:15:05 INFO - Running post-action listener: _start_resource_monitoring 14:15:05 INFO - Starting resource monitoring. 14:15:05 INFO - ##### 14:15:05 INFO - ##### Running install step. 14:15:05 INFO - ##### 14:15:05 INFO - Running pre-action listener: _resource_record_pre_action 14:15:05 INFO - Running main action method: install 14:15:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:15:05 INFO - Reading from file tmpfile_stdout 14:15:05 INFO - Detecting whether we're running mozinstall >=1.0... 14:15:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:15:05 INFO - Reading from file tmpfile_stdout 14:15:05 INFO - Output received: 14:15:05 INFO - Usage: mozinstall [options] installer 14:15:05 INFO - Options: 14:15:05 INFO - -h, --help show this help message and exit 14:15:05 INFO - -d DEST, --destination=DEST 14:15:05 INFO - Directory to install application into. [default: 14:15:05 INFO - "/builds/slave/test"] 14:15:05 INFO - --app=APP Application being installed. [default: firefox] 14:15:05 INFO - mkdir: /builds/slave/test/build/application 14:15:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:15:40 INFO - Reading from file tmpfile_stdout 14:15:40 INFO - Output received: 14:15:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:15:40 INFO - Running post-action listener: _resource_record_post_action 14:15:40 INFO - ##### 14:15:40 INFO - ##### Running run-tests step. 14:15:40 INFO - ##### 14:15:40 INFO - Running pre-action listener: _resource_record_pre_action 14:15:40 INFO - Running main action method: run_tests 14:15:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:15:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:15:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:15:40 INFO - 2016-03-22 14:15:40.557 screenresolution[1652:8130] starting screenresolution argv=screenresolution get 14:15:40 INFO - 2016-03-22 14:15:40.560 screenresolution[1652:8130] Display 0: 1600x1200x32@60 14:15:40 INFO - 2016-03-22 14:15:40.565 screenresolution[1653:8132] starting screenresolution argv=screenresolution list 14:15:40 INFO - Available Modes on Display 0 14:15:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:15:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:15:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:15:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:15:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:15:40 INFO - Intel Iris: 14:15:40 INFO - Chipset Model: Intel Iris 14:15:40 INFO - Type: GPU 14:15:40 INFO - Bus: Built-In 14:15:40 INFO - VRAM (Dynamic, Max): 1536 MB 14:15:40 INFO - Vendor: Intel (0x8086) 14:15:40 INFO - Device ID: 0x0a2e 14:15:40 INFO - Revision ID: 0x0009 14:15:40 INFO - Displays: 14:15:40 INFO - Display: 14:15:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:15:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:15:40 INFO - Display Serial Number: 1600x1200 60 14:15:40 INFO - Main Display: Yes 14:15:40 INFO - Mirror: Off 14:15:40 INFO - Online: Yes 14:15:40 INFO - Rotation: Supported 14:15:40 INFO - Return code: 0 14:15:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:15:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:15:40 INFO - Python 2.7.3 14:15:40 INFO - Return code: 0 14:15:40 INFO - grabbing minidump binary from tooltool 14:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:40 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 0x107d32e00>, '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 0x107b5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d2db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:15:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:15:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:15:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:15:40 INFO - Return code: 0 14:15:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:15:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:15:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:15:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:15:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:15:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:15:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:15:42 INFO - Return code: 0 14:15:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:15:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C0VbIPbPfw/Render', 14:15:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:42 INFO - 'HOME': '/Users/cltbld', 14:15:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:42 INFO - 'LOGNAME': 'cltbld', 14:15:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:15:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:42 INFO - 'MOZ_NO_REMOTE': '1', 14:15:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:15:42 INFO - 'NO_EM_RESTART': '1', 14:15:42 INFO - 'PAGER': '/bin/cat', 14:15:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:42 INFO - 'PWD': '/builds/slave/test', 14:15:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:15:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:42 INFO - 'SHELL': '/bin/bash', 14:15:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yFkNcc8kxp/Listeners', 14:15:42 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 14:15:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:42 INFO - 'USER': 'cltbld', 14:15:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:42 INFO - 'XPC_FLAGS': '0x0', 14:15:42 INFO - 'XPC_SERVICE_NAME': '0', 14:15:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:15:42 INFO - mozversion application_buildid: 20160322123449 14:15:42 INFO - mozversion application_changeset: b60392ce5fb443b3629e95037d6e2e299f3ee08e 14:15:42 INFO - mozversion application_display_name: Nightly 14:15:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:15:42 INFO - mozversion application_name: Firefox 14:15:42 INFO - mozversion application_remotingname: firefox 14:15:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:15:42 INFO - mozversion application_vendor: Mozilla 14:15:42 INFO - mozversion application_version: 48.0a1 14:15:42 INFO - mozversion platform_buildid: 20160322123449 14:15:42 INFO - mozversion platform_changeset: b60392ce5fb443b3629e95037d6e2e299f3ee08e 14:15:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:15:42 INFO - mozversion platform_version: 48.0a1 14:15:42 INFO - using testdate: 1458681342 14:15:42 INFO - actual date: 1458681342 14:15:42 INFO - starting webserver on 'localhost:49270' 14:15:42 INFO - SUITE-START | Running 2 tests 14:15:42 INFO - TEST-START | dromaeo_css 14:15:42 INFO - operating with platform_type : mac_ 14:15:42 INFO - Initialising browser for dromaeo_css test... 14:15:42 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmptJnTUq/profile http://localhost:49270/getInfo.html) 14:15:44 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 14:15:44 INFO - PROCESS | 1671 | colorDepth:24 14:15:44 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 14:15:44 INFO - PROCESS | 1671 | __metrics 14:15:44 INFO - PROCESS | 1671 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:15:44 ERROR - PROCESS | 1671 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:15:45 INFO - TEST-INFO | 1671: exit 0 14:15:45 INFO - Browser initialized. 14:15:45 INFO - Running cycle 1/1 for dromaeo_css test... 14:15:45 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmptJnTUq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:15:57 INFO - PROCESS | 1675 | RSS: Main: 245542912 14:15:57 INFO - PROCESS | 1675 | 14:16:48 INFO - PROCESS | 1675 | 1458681408648 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:18:58 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 14:19:00 INFO - PROCESS | 1675 | RSS: Main: 452263936 14:19:00 INFO - PROCESS | 1675 | 14:22:03 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 14:22:04 INFO - PROCESS | 1675 | RSS: Main: 379133952 14:22:04 INFO - PROCESS | 1675 | 14:25:06 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 14:25:06 INFO - PROCESS | 1675 | RSS: Main: 379985920 14:25:06 INFO - PROCESS | 1675 | 14:28:08 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 14:28:09 INFO - PROCESS | 1675 | RSS: Main: 338128896 14:28:09 INFO - PROCESS | 1675 | 14:31:12 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 14:31:12 INFO - PROCESS | 1675 | RSS: Main: 337711104 14:31:12 INFO - PROCESS | 1675 | 14:34:15 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 14:34:15 INFO - PROCESS | 1675 | RSS: Main: 419717120 14:34:15 INFO - PROCESS | 1675 | 14:34:15 INFO - PROCESS | 1675 | __start_tp_report 14:34:15 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 14:34:15 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 14:34:15 INFO - PROCESS | 1675 | |i|pagename|runs| 14:34:15 INFO - PROCESS | 1675 | |0;dojo.html;3398.7620866539346;3463.619001909791;3466.6360032196635;3485.8082805445706;3537.1687653401445;5514.0901751211;5549.667019978804;5580.023495888218;5629.943700562998;5633.746481408336;4561.863144105674;5493.258410114633;5542.584306177033;5546.667199967995;5572.7770889164385;5029.647924645267;5056.898862022757;5087.465816089294;5143.408508021569;5146.485351464842;5086.694798312114;5093.745312734367;5150.896982060356;5153.407358153804;5168.61235407346;5125.974370128144;5146.794128234885;5155.871103222412;5182.559482443978;5186.377634683843;5168.741562921858;5222.242774797652;5236.633435659505;5237.47625237477;5287.814926477555;4096.836126554934;4989.725565093919;5114.41184263807;5126.846194614168;5154.433012368637;5311.7344132793205;5454.154606036071;5465.289512363407;5473.726313684339;5534.08687566551;6069.969650151721;6082.391760823926;6096.664683442409;6097.268327800648;6105.847353816146;6051.364606716319;6139.048447490602;6166.568340216187;6171.074338849164;6178.814635560941;5754.942450575482;5772.595918285764;5784.305883294031;5788.131780232999;5823.4467725566;6132.877342453126;6205.100260462208;6212.627242365473;6213.65824879636;6220.377962203744;5863.882722345529;5981.162637230791;6052.939470605237;6055.455009049207;6086.087086936995;6139.188686267213;6164.260288765377;6190.81427557174;6197.225346831646;6197.845053873599;6069.15031895535;6112.449879510777;6124.816255512342;6145.170401995673;6163.537734669918;5964.7315870785915;6068.21113255274;6069.453749162508;6128.472568454217;6143.696113957266;4760.59534939534;4778.092162489116;4783.473817880031;4806.255030470283;4823.686460380134;4079.3065178919655;4312.223799716018;4313.827446902152;4326.978365108154;4375.321825117112;5365.624406291522;5442.619016668875;5453.890922181534;5462.262594549765;5475.479829416199;6146.323904370515;6205.2553693557065;6206.596571222856;6213.347598502182;6221.5333849960525;5510.201020851954;5556.972215138899;5561.749721262553;5562.054450743383;5591.217229587861;5158.3552055993005;5194.844154675366;5292.417834038252;5309.7079660618265;5310.283111779938;6155.35368786271;6218.751249950042;6222.315545289924;6228.750849966042;6231.875362492634;6164.075388691732;6166.599171053867;6167.691615419121;6175.2589689237575;6176.073588961692;6146.985747351637;6156.599821011799;6181.84545386351;6184.845378865564;6246.969250073687;6065;6099.542534309856;6119.816405507842;6139.171211886517;6139.631622102688;6137.011896361508;6189.876202475835;6191.597546159485;6196.566240363131;6230.190075290183;5783.508401785727;5909.70451477433;5913.319968203539;5917.319508256605;6026.020547774785;5858.502027327725;5933.050711886078;5934.673592952429;5936.139259807217;5944.464998150187;5095.974520127375;5660.150977353265;5801.709914504174;5808.94191058084;5812.447817457335;4917.237828136645;5778.913316300343;5933.495652869382;6003.309619393651;6110.175126357884;5772.6536407815665;5868.061110222344;5928.9407105928385;5939.673317967553;6005.609635373687 14:34:15 INFO - PROCESS | 1675 | |1;ext.html;456.6118799020833;472.5487159762427;578.8423153692614;624.1137584629826;632.5919781740779;33907.32185356291;38244;38305.04237394067;38394.616053839454;38522;39282.82151535452;39963.60036399635;39963.800180999126;40014.59985400145;40075.59735409261;9288.814223715539;9528.761780955498;9544.61821527138;9572.32993690442;9574.186194173504;9369.48467834269;9643.373180743229;9651.083147101013;9652.806943861118;9655.420674759502;9600.471974041426;9675.371100878456;9684.75788105296;9697.75755606112;9710.9514452428;9563.378380405285;9654.903450965507;9670.613175472972;9677.516124193762;9695.70912872615;9477.810443791155;9620.615175392975;9629.470379129145;9629.711108666752;9630.27772917034;38160.80919595412;38594.61405385938;38607.8417647471;38636.420453693216;38779.030524236834;3242.093545629835;3296.9505457417918;3634.582023067328;3749.887503374903;3892.4550562921213;27929.581056284173;28702.71297287042;29219;29327.973520926666;29345.559816602767;2210.823134149264;2720.197541725176;2746.148693904896;2796.4826507096254;2814.8592570371397;496177;498039.9999999964;499919;500055;500153;45797.77101114473;46670;46765.76617116893;59762.70118649379;61599.768004639656;46447.07105857864;46676.29985550219;46736.76631616888;46791.5320846794;46802.531974680496;15761.369545218064;15959.760603590956;15968.840311596967;15980.76028859568;15983.920080399523;12680.746385072247;12754.80867786984;12762.61712148637;12773.61679149627;12782.552610658582;15153.393864245307;15157.362233064207;15196.088234705952;15198.088114713153;15301.693966120616;6387.872242555123;6539.771108011292;6581.934180658228;6595.208574971034;6607.57050791697;971.3055165556661;989.6882482018141;1012.3268026762121;1069.3637285815082;1109.8834622364536;29839.701602984125;29925.85037074801;30458.84770576133;30721.231969200948;30802;1074.2641290715728;1146.1747541769912;1184.9881501184877;1199.5561642192445;1295.313483853559;13030.58934097195;15158.166300853338;15268.541943741706;15410.6147346315;15869.52391428236;482376;520658.396708014;521261.7558385438;521837;521843.39078304364;57254.427455725745;59241;59351.10973335403;59424.70287648534;59544.40455595475;1378.9793153102712;1384.8199734034713;1478.7855760914608;1492.4179569967505;1521.6652336486177;22386.440338991655;29125.563116552847;29154.271143221587;29966.70033299639;29972.70027299699;45152.774236129924;45206.54793452155;45616.54383456123;45630;45638.08723825571;336081;337041;337127;338100;338563;34534.48198276978;34948.30103397969;42990;44745.88135296643;44817.87955301144;43567.782161088995;43806.56193438025;44077.33883991807;44283.77858110689;44716.77641611901;36231.27537449289;36787.264254714224;37033.81483092675;37402;37747.245055099294;31077.446127693074;35843.64156358403;36334.454983175805;36743;37599.43600846044;36501;36543.81728091343;37030.8148459256;37441.251174975805;37765.81117094397;32147.67852321447;32390.028299151065;32510.187245319055;32617.673823262412;32748.017559473254;24164.63753043741;24543.38641533976;24556.01775928943;24586.38534036592;24804.50390992134 14:34:15 INFO - PROCESS | 1675 | |2;jquery.html;363.6399964035604;363.7090327737809;365.23483302481293;375.62625187938005;376.54062044305954;19236.519087022833;19956.201751929922;21287.893560532175;21351.466213344673;21351.67972480414;20428.89785551074;20474.976251187454;21230.25694100707;21260.14959401626;21374.931253437306;4295.377170310303;6026.246719160105;6047.092936059582;6075.969620151893;6076.3316035236085;5475.808346707866;5744.971275143618;5746.367899531048;5752.5110365618975;5837.562182836283;4838.830640927568;5717.371089180187;5735.827925162252;5745.942540574582;5746.712664366786;5723.17014032967;6073.7874174403905;6172.22847144107;6228.37716228378;6231.87536249277;5584.46947539983;5606.159076138571;5614.073677843151;5616.887662246773;5620.971895140539;23530;23832.64251036236;24536;24804.751952480605;24856.005759769767;1930.4305229957197;2101.77931317211;2180.8146307563875;2244.8540844845033;2741.876615552305;9743.805123897482;9873.555689993897;9998.350107243006;10011.949940250252;10084.445355505444;1739.765131707216;1793.5695433095964;1800.9099545022696;1817.270023485489;1836.7795864496345;103410;104279;104324.99999999924;104849.99999999924;108217.45891270573;9931.304808663468;10869.804321524625;11212.66362009141;11271.718207044725;11713.238639488405;13756.931215343859;13807.861921380658;13916.930415347859;13917.23455209953;13940.721185576233;8440.029396619344;8451.577421128919;8531.10423405546;8658.220760131619;8775.956120219358;8510.70212542558;8702.825943481095;8748.34387420946;8802.86795698065;8874.733757987271;4514.7291162530355;4579.702319349231;4596.47140578831;4607.262837945913;4628.83799067031;1907.5326544996287;1938.7220016480578;1949.83426408754;1962.4701330640646;1964.5383334916282;835.8579041562949;879.8944126704837;924.4822899176482;1004.929654924163;1012.3829061519156;16659.66722662184;20565.69151462729;20852.12330890197;20853.37439876806;20954.0570674317;938.6808485115093;980.9313348065709;985.8422652375585;1001.1840350114634;1001.6143784642965;10873.510692018877;11129.162063673873;11178.329300242012;11200.831987520194;11212.822653621415;582586;591872;619367;631496;638797;115543;118498;118616.62766744789;119032;119141;1034.5499707627055;1038.1746511523206;1051.9000694933968;1056.7569459024467;1057.1384321777728;18355.908220458812;18514.98167600795;18583.628327433104;18675.626487469905;18692.34576789806;41236.96907577335;51954.480455194964;53502;53701.19448208202;53977.46022539724;75150.62424687842;75692;75979.86030209663;76459;76984;7783.532988020737;10592.841107383549;10940.445714512436;11123;11155.888441115485;8605.612747426507;8630.870536941826;8764.21122099014;8775.034746178044;9181.035991221093;7718.382529397747;7843.411674147632;7864.764057078297;7866.370690344645;8117.878231826646;7584.810379740551;7712.228777122243;7857.017872765904;7887.053553573378;8012.959935200287;7722.173641474079;7933.761987140395;7939.166387529226;7956.085050219299;8381.664733410595;10439.060484556123;10748.731281718019;11337.603183888854;11374.829377559508;11618.825717614412;10179.98200179976;10277.383356998604;10623.521941512496;11317.094632429222;11491.080713543064 14:34:15 INFO - PROCESS | 1675 | |3;mootools.html;1470.2207829850183;1602.7195240832855;1643.1537758054603;1936.3126090237965;2053.28238077795;8075.273225409712;8559.614817333219;8766.95616521918;8779.209871111607;8783.209511143996;7114.750983715571;8760.518171500566;8877.289816814655;8887.377883548153;8901.599428025738;2168.2844661261747;2402.3994001499627;2479.8636075015866;2488.2582192465256;2503.486785209028;2496.3509487533283;2500.612405077216;2510.6736124303816;2515.019142534413;2523.1169090818157;2420.1166574200465;2472.8763561821925;2495.5258500884865;2496.1263557754824;2498.7001559812848;2401.9023784716123;2422.994457300218;2482.4042229864795;2485.5898776701824;2489.65144879717;2431.0761910474084;2473.9628905566433;2479.2810085075307;2480.218731099698;2485.3413845331;8949.955250223773;9030.909690903138;9031.503267320295;9037.502937338444;9049.77375565616;5511.641743286714;5594.1608758686525;5628.493435590816;5631.690257035862;5646.915296270559;2994.2065352681557;3588.946165807515;3759.868404605853;3764.0401697567218;3793.3172029034763;1053.3048188195753;1071.860658114448;1079.854219680341;1086.6902932664232;1088.5373716170675;12275.754484910341;12293;12321.199122057127;12333.013358931265;12336.321502317369;4073.8796830871747;4917.188663870493;5019.0463811875625;5029.5724863386295;5055.8988820223385;10194.388336699822;10283.023112804272;10284.845727314096;10289.94855025735;10304.742381440374;5573.164025396223;5613.859653508695;5614.29821272341;5622.634528755618;5625.212470254168;4476.060027394218;4590.609798167126;4969.527894849984;5068.923966140511;5074.797008119708;3942.5860284669698;4038.172174704179;4057.7159598827798;4079.85720499787;4108.958910410857;1325.370449036719;1337.4048548396065;1347.0907137682025;1350.7771217748962;1356.1795113955914;1210.6912737251944;1340.1690951610065;1389.4442223110836;1390.5550223928449;1393.2267591486823;8329.916700833035;8385.161483851565;8400.117987611335;8414.621342039623;8427.873581896276;511.9155339368962;524.5384062025394;526.0714838310386;528.355406404194;531.5083547718423;4995.250712393097;6232.470240029557;6242.09489624002;6262.718177682015;6267.6866156692895;10223.284370094021;10485.842712359321;10616.734581635521;10623.628173013907;10638.414887181125;10238.53926573306;10381.84427233592;10495.055445009986;10504.632337868137;10510.369377837354;8239.217274358927;8287.875681864776;8343.290820280345;8361.247487726134;8440.282575981111;8067.556284404414;8137.471064380797;8142.47073940192;8207.589620518831;8381.078081410918;8074.677012919417;9803.558839852367;9850;9890.456024918698;9901.950490247502;10159.390436573534;10207.285490015627;10237.283390162616;10238.948805255926;10373.377597344184;6885.827854303682;7216.278372162742;7521.736739214101;7611.467197296136;7757.844843102994;8378.120297368689;8406.789830254293;8449.87325190135;8457.534835584102;8464.915350846413;6016.21789167423;7320.231375705474;7404.518706284074;7550.395968322411;7551.509151905108;7218.747343843151;7285.963570182115;7290.890636640561;7324.523905946096;7345.971563981154;7644.3120119187315;7754.147043825287;7768.689252429839;7770.728024519115;7788.727394541391;6940.687669054803;6961.338672826073;7032.578045317297;7036.944458331292;7042.0493233412835;7090.1491820979745;7160.964195178991;7206.2793720627515;7226.819329516804;7234.674439650334 14:34:15 INFO - PROCESS | 1675 | |4;prototype.html;318.2521075472639;324.982125983071;330.0066798935204;330.0971842012095;332.26735049216495;6576.539642225046;6632.635205063725;6645.966770166148;6672.866542669156;6687.465002799777;6481.222253329607;6535.3137920518375;6554.2462616799085;6560;6567.737290508386;4615.65382596305;4680.812767489297;4756.07256584966;4771.761411929407;4850.078485087831;4784.808607655689;4799.712017278975;4820.469748327681;4843.757812109398;4847.975760121194;4761.690490118149;4784.473707892129;4817.51824817519;4818.421789385278;4822.156122678535;4574.19951508488;4648.48866624671;4759.690620109682;4767;4818.132736107516;4058.4723985881647;4076.510818701745;4077.041895154636;4078.5717499662405;4098.610631989956;6252;6265.655388953605;6285.685715714196;6298.685065746694;6314.557980941336;5613.663180209201;5628.9305032043785;5642.520385767215;5649.23735295734;5656.123300888369;6924.376806087426;6929.029935808991;6929.72281108755;6937.653117344163;6949.861002779967;4454.28731402974;4514.480834703985;4591.678582499227;4621.838235661769;4629.513901040376;7231.819204519877;7293.030881661922;7294.671739771723;7312.8171795705;7319.817004574875;4672.112298663243;4675.602573781199;4681.204195286809;4683.431050598019;4700.929486057712;4277.401163837066;4420.585412667915;4755.619550436026;4763.7141771493825;4780.784864681028;5606.766511367493;5613.298337707786;5636.2954630671165;5640.520555752807;5644.8306550803545;6610.96694516534;6889.724411023603;6981.511294209458;6986.371226589631;6991.545549539263;1330.4744625872727;1584.9366025359086;1592.0606841963297;1607.7829493018294;1608.9863386066936;887.6538150121457;1007.8309161372919;1017.7710015246511;1022.9437380943971;1025.5333823110616;6234.657093859882;6306.590071645328;6387.073874288202;6405.455536279375;6444.903326450107;7232.927670723226;7258.165310989199;7276.454265930077;7278.308560686726;7283.817904552428;6429.774957876545;6430.8103000944975;6432.678366081677;6437.130987316746;6456.322086180978;3799.1831756172555;3836.7506112103183;3844.2503711776494;3848.5574158972076;3862.3627101528496;7293.927060729431;7578.886316705254;7603.9619801900635;7642.694292228249;7675.002249707502;7489.3634041106025;7533.4349923755935;7536.7362142324755;7539.811504712426;7550.6602202901;7598.924010759822;7611.733589324347;7613.352865006425;7623.847523049508;7627.809304767426;5904.5866789326055;7234.16807067194;7235.529690570306;7256.854862902606;7267.127944646465;6455.7740479083;6852.588844669336;7194.748183813542;7221.602811845399;7226.927730722836;7586.544807311579;7630.236976302325;7636.045494313211;7641.2740789624895;7642.694292228249;4483.820647174077;4495.168393847149;4502.527234640315;4506.662000350052;4508;6221.688915554114;6908.507736349514;7203.639818008974;7243.45674074436;7254.637268136677;6715.832104197239;6971.860562788817;7032.964835175791;7033.683484243119;7044.929550704427;6975.930240697731;7012.824679383056;7026.367626913602;7029.3673569379;7032.156141263081;6868.278830722902;6871.5189936703955;6871.553349032297;6877.828054298682;6881.277465866012;6721.126253587003;6986.6157361343585;7008.528209076151;7011.6844741985715;7016.403605693369;6624.205095388585;6779.593224406552;6781.627010514272;6872.862542749017;6902.896456553256 14:34:15 INFO - PROCESS | 1675 | |5;yui.html;666.8366250268685;673.1787219592097;750.7560042986028;763.1795819494043;772.9072511298644;14039.578812635624;14351.35418906149;14405.783913241283;14406.423743050278;14437.711245775105;14292.642683932881;14320.713585728305;14423.711525769479;14434.42262309509;14475.98668093234;931.3573634192419;967.3325405470238;969.2246203037541;969.8157350103493;971.8736564246637;942.1708896171359;955.126059655418;956.4213650741306;956.8612551180074;958.0467434902282;988.3723835364524;992.5979978108877;992.9821932519153;993.4734590666958;994.0705440413237;981.40134517944;982.4400091947592;987.1707765476998;987.6740675577042;994.7910938702881;735.4410647907575;735.808689740666;736.3593673504085;736.9410447164214;737.7196665267218;15824.76262856058;15896;15903.045817251003;15925.681486370207;15950.042997420192;12477.251364918135;12479.875201247962;12629.24224546521;12691.682707932283;12914.411916075798;10060.547275372626;10095.596176152945;10322.967703229691;10625.681229563048;10771.676849694522;3435.914102147441;3438.673326034023;3449.2847048322815;3532.9646703532894;3576.356255873942;87175;87840.56079719625;88914;88972.55513722455;89088;9243.121903419164;9402.717918462457;9462.29032822541;9557.378770379903;10140.695779126638;21826.908654567207;21856.344309670734;21866.016029278722;21889;21920.45198870041;7371.631418429164;7413.962930185422;7468;7472.626368681545;7596.886046709304;4141.358089496133;4197.118605092904;4204.600562946515;4213.1994920965535;4213.599708027732;3598.9640103599154;3645.799481028569;3648.3432982062955;3649.8540058397366;3650.3064417760543;653.8986457099157;660.2802944790202;664.1697877652933;668.5888178770022;674.6019848289533;501.7756673716121;533.66112518551;589.8613825750945;595.1013968906982;614.6035806904522;7079.327463890922;8002.439829212016;8134.75595732129;8250.216229458192;8291.419600627898;563.7125066216178;575.2119596153296;589.4812564942823;594.191899017336;602.2832828933555;3841.7887016213817;3853.7109716771356;3875.9418608720894;3882.6117388261514;4070.1452694934396;89510;91418;92872;93024.53487732518;96618.51690741502;68220;75710.62144689242;82414.58792705998;82592;84649;68436;70420.29579704137;72535;72580.63709681417;73583.89624155642;8204.097549269694;8305.709300174465;8502.489850608983;8533.53065581399;8553.657853685783;47881;48170.759146204044;48657.756711216214;49356;50172.749136255545;61615.459613508225;64637.67681161564;64883.35116648962;65218.67390663016;65608;10789.514471848943;10925.83611245816;11006.779864402828;11121.499532520895;11258.324500529994;11708.941455292668;11835.644930652094;11855.34795586251;11899.821502677294;12242.387880606113;11287.604933827277;11440.141989350666;11518.769624607294;11587.8261826071;11942.402879856147;11568.363739994382;11585.362805045803;11875.456190695155;11880.881191187977;11895.167338286237;11205.271657342246;11277.71805704864;11408.94295528517;11541.076713863038;11633.185677002528;9435.622575097193;9461.38500997433;9466.479343636167;9487.383320084173;9597.856032159383;9201.401908876169;9587.137157655845;9713.271504637321;9715.805683886425;9850.802983940137 14:34:15 INFO - PROCESS | 1675 | __end_tp_report 14:34:15 INFO - PROCESS | 1675 | __start_cc_report 14:34:15 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,2194 14:34:15 INFO - PROCESS | 1675 | __end_cc_report 14:34:15 INFO - PROCESS | 1675 | __startTimestamp1458682455697__endTimestamp 14:34:15 INFO - PROCESS | 1675 | 14:34:15 INFO - PROCESS | 1675 | ------- Summary: start ------- 14:34:15 INFO - PROCESS | 1675 | Number of tests: 6 14:34:15 INFO - PROCESS | 1675 | 14:34:15 INFO - PROCESS | 1675 | [#0] dojo.html Cycles:165 Average:5619.87 Median:5812.45 stddev:637.83 (11.0%) stddev-sans-first:615.52 14:34:15 INFO - PROCESS | 1675 | Values: 3398.8 3463.6 3466.6 3485.8 3537.2 5514.1 5549.7 5580.0 5629.9 5633.7 4561.9 5493.3 5542.6 5546.7 5572.8 5029.6 5056.9 5087.5 5143.4 5146.5 5086.7 5093.7 5150.9 5153.4 5168.6 5126.0 5146.8 5155.9 5182.6 5186.4 5168.7 5222.2 5236.6 5237.5 5287.8 4096.8 4989.7 5114.4 5126.8 5154.4 5311.7 5454.2 5465.3 5473.7 5534.1 6070.0 6082.4 6096.7 6097.3 6105.8 6051.4 6139.0 6166.6 6171.1 6178.8 5754.9 5772.6 5784.3 5788.1 5823.4 6132.9 6205.1 6212.6 6213.7 6220.4 5863.9 5981.2 6052.9 6055.5 6086.1 6139.2 6164.3 6190.8 6197.2 6197.8 6069.2 6112.4 6124.8 6145.2 6163.5 5964.7 6068.2 6069.5 6128.5 6143.7 4760.6 4778.1 4783.5 4806.3 4823.7 4079.3 4312.2 4313.8 4327.0 4375.3 5365.6 5442.6 5453.9 5462.3 5475.5 6146.3 6205.3 6206.6 6213.3 6221.5 5510.2 5557.0 5561.7 5562.1 5591.2 5158.4 5194.8 5292.4 5309.7 5310.3 6155.4 6218.8 6222.3 6228.8 6231.9 6164.1 6166.6 6167.7 6175.3 6176.1 6147.0 6156.6 6181.8 6184.8 6247.0 6065.0 6099.5 6119.8 6139.2 6139.6 6137.0 6189.9 6191.6 6196.6 6230.2 5783.5 5909.7 5913.3 5917.3 6026.0 5858.5 5933.1 5934.7 5936.1 5944.5 5096.0 5660.2 5801.7 5808.9 5812.4 4917.2 5778.9 5933.5 6003.3 6110.2 5772.7 5868.1 5928.9 5939.7 6005.6 14:34:15 INFO - PROCESS | 1675 | 14:34:15 INFO - PROCESS | 1675 | [#1] ext.html Cycles:180 Average:59202.54 Median:38202.40 stddev:121529.28 (318.1%) stddev-sans-first:121790.16 14:34:15 INFO - PROCESS | 1675 | Values: 456.6 472.5 578.8 624.1 632.6 33907.3 38244.0 38305.0 38394.6 38522.0 39282.8 39963.6 39963.8 40014.6 40075.6 9288.8 9528.8 9544.6 9572.3 9574.2 9369.5 9643.4 9651.1 9652.8 9655.4 9600.5 9675.4 9684.8 9697.8 9711.0 9563.4 9654.9 9670.6 9677.5 9695.7 9477.8 9620.6 9629.5 9629.7 9630.3 38160.8 38594.6 38607.8 38636.4 38779.0 3242.1 3297.0 3634.6 3749.9 3892.5 27929.6 28702.7 29219.0 29328.0 29345.6 2210.8 2720.2 2746.1 2796.5 2814.9 496177.0 498040.0 499919.0 500055.0 500153.0 45797.8 46670.0 46765.8 59762.7 61599.8 46447.1 46676.3 46736.8 46791.5 46802.5 15761.4 15959.8 15968.8 15980.8 15983.9 12680.7 12754.8 12762.6 12773.6 12782.6 15153.4 15157.4 15196.1 15198.1 15301.7 6387.9 6539.8 6581.9 6595.2 6607.6 971.3 989.7 1012.3 1069.4 1109.9 29839.7 29925.9 30458.8 30721.2 30802.0 1074.3 1146.2 1185.0 1199.6 1295.3 13030.6 15158.2 15268.5 15410.6 15869.5 482376.0 520658.4 521261.8 521837.0 521843.4 57254.4 59241.0 59351.1 59424.7 59544.4 1379.0 1384.8 1478.8 1492.4 1521.7 22386.4 29125.6 29154.3 29966.7 29972.7 45152.8 45206.5 45616.5 45630.0 45638.1 336081.0 337041.0 337127.0 338100.0 338563.0 34534.5 34948.3 42990.0 44745.9 44817.9 43567.8 43806.6 44077.3 44283.8 44716.8 36231.3 36787.3 37033.8 37402.0 37747.2 31077.4 35843.6 36334.5 36743.0 37599.4 36501.0 36543.8 37030.8 37441.3 37765.8 32147.7 32390.0 32510.2 32617.7 32748.0 24164.6 24543.4 24556.0 24586.4 24804.5 14:34:15 INFO - PROCESS | 1675 | 14:34:15 INFO - PROCESS | 1675 | [#2] jquery.html Cycles:180 Average:34384.50 Median:364.47 stddev:101740.45 (27914.5%) stddev-sans-first:101993.79 14:34:15 INFO - PROCESS | 1675 | Values: 363.6 363.7 365.2 375.6 376.5 19236.5 19956.2 21287.9 21351.5 21351.7 20428.9 20475.0 21230.3 21260.1 21374.9 4295.4 6026.2 6047.1 6076.0 6076.3 5475.8 5745.0 5746.4 5752.5 5837.6 4838.8 5717.4 5735.8 5745.9 5746.7 5723.2 6073.8 6172.2 6228.4 6231.9 5584.5 5606.2 5614.1 5616.9 5621.0 23530.0 23832.6 24536.0 24804.8 24856.0 1930.4 2101.8 2180.8 2244.9 2741.9 9743.8 9873.6 9998.4 10011.9 10084.4 1739.8 1793.6 1800.9 1817.3 1836.8 103410.0 104279.0 104325.0 104850.0 108217.5 9931.3 10869.8 11212.7 11271.7 11713.2 13756.9 13807.9 13916.9 13917.2 13940.7 8440.0 8451.6 8531.1 8658.2 8776.0 8510.7 8702.8 8748.3 8802.9 8874.7 4514.7 4579.7 4596.5 4607.3 4628.8 1907.5 1938.7 1949.8 1962.5 1964.5 835.9 879.9 924.5 1004.9 1012.4 16659.7 20565.7 20852.1 20853.4 20954.1 938.7 980.9 985.8 1001.2 1001.6 10873.5 11129.2 11178.3 11200.8 11212.8 582586.0 591872.0 619367.0 631496.0 638797.0 115543.0 118498.0 118616.6 119032.0 119141.0 1034.5 1038.2 1051.9 1056.8 1057.1 18355.9 18515.0 18583.6 18675.6 18692.3 41237.0 51954.5 53502.0 53701.2 53977.5 75150.6 75692.0 75979.9 76459.0 76984.0 7783.5 10592.8 10940.4 11123.0 11155.9 8605.6 8630.9 8764.2 8775.0 9181.0 7718.4 7843.4 7864.8 7866.4 8117.9 7584.8 7712.2 7857.0 7887.1 8013.0 7722.2 7933.8 7939.2 7956.1 8381.7 10439.1 10748.7 11337.6 11374.8 11618.8 10180.0 10277.4 10623.5 11317.1 11491.1 14:34:15 INFO - PROCESS | 1675 | 14:34:15 INFO - PROCESS | 1675 | [#3] mootools.html Cycles:180 Average:6093.78 Median:2793.36 stddev:3239.41 (116.0%) stddev-sans-first:3229.85 14:34:15 INFO - PROCESS | 1675 | Values: 1470.2 1602.7 1643.2 1936.3 2053.3 8075.3 8559.6 8767.0 8779.2 8783.2 7114.8 8760.5 8877.3 8887.4 8901.6 2168.3 2402.4 2479.9 2488.3 2503.5 2496.4 2500.6 2510.7 2515.0 2523.1 2420.1 2472.9 2495.5 2496.1 2498.7 2401.9 2423.0 2482.4 2485.6 2489.7 2431.1 2474.0 2479.3 2480.2 2485.3 8950.0 9030.9 9031.5 9037.5 9049.8 5511.6 5594.2 5628.5 5631.7 5646.9 2994.2 3588.9 3759.9 3764.0 3793.3 1053.3 1071.9 1079.9 1086.7 1088.5 12275.8 12293.0 12321.2 12333.0 12336.3 4073.9 4917.2 5019.0 5029.6 5055.9 10194.4 10283.0 10284.8 10289.9 10304.7 5573.2 5613.9 5614.3 5622.6 5625.2 4476.1 4590.6 4969.5 5068.9 5074.8 3942.6 4038.2 4057.7 4079.9 4109.0 1325.4 1337.4 1347.1 1350.8 1356.2 1210.7 1340.2 1389.4 1390.6 1393.2 8329.9 8385.2 8400.1 8414.6 8427.9 511.9 524.5 526.1 528.4 531.5 4995.3 6232.5 6242.1 6262.7 6267.7 10223.3 10485.8 10616.7 10623.6 10638.4 10238.5 10381.8 10495.1 10504.6 10510.4 8239.2 8287.9 8343.3 8361.2 8440.3 8067.6 8137.5 8142.5 8207.6 8381.1 8074.7 9803.6 9850.0 9890.5 9902.0 10159.4 10207.3 10237.3 10238.9 10373.4 6885.8 7216.3 7521.7 7611.5 7757.8 8378.1 8406.8 8449.9 8457.5 8464.9 6016.2 7320.2 7404.5 7550.4 7551.5 7218.7 7286.0 7290.9 7324.5 7346.0 7644.3 7754.1 7768.7 7770.7 7788.7 6940.7 6961.3 7032.6 7036.9 7042.0 7090.1 7161.0 7206.3 7226.8 7234.7 14:34:15 INFO - PROCESS | 1675 | 14:34:15 INFO - PROCESS | 1675 | [#4] prototype.html Cycles:180 Average:5721.09 Median:6456.05 stddev:1837.96 (28.5%) stddev-sans-first:1797.82 14:34:15 INFO - PROCESS | 1675 | Values: 318.3 325.0 330.0 330.1 332.3 6576.5 6632.6 6646.0 6672.9 6687.5 6481.2 6535.3 6554.2 6560.0 6567.7 4615.7 4680.8 4756.1 4771.8 4850.1 4784.8 4799.7 4820.5 4843.8 4848.0 4761.7 4784.5 4817.5 4818.4 4822.2 4574.2 4648.5 4759.7 4767.0 4818.1 4058.5 4076.5 4077.0 4078.6 4098.6 6252.0 6265.7 6285.7 6298.7 6314.6 5613.7 5628.9 5642.5 5649.2 5656.1 6924.4 6929.0 6929.7 6937.7 6949.9 4454.3 4514.5 4591.7 4621.8 4629.5 7231.8 7293.0 7294.7 7312.8 7319.8 4672.1 4675.6 4681.2 4683.4 4700.9 4277.4 4420.6 4755.6 4763.7 4780.8 5606.8 5613.3 5636.3 5640.5 5644.8 6611.0 6889.7 6981.5 6986.4 6991.5 1330.5 1584.9 1592.1 1607.8 1609.0 887.7 1007.8 1017.8 1022.9 1025.5 6234.7 6306.6 6387.1 6405.5 6444.9 7232.9 7258.2 7276.5 7278.3 7283.8 6429.8 6430.8 6432.7 6437.1 6456.3 3799.2 3836.8 3844.3 3848.6 3862.4 7293.9 7578.9 7604.0 7642.7 7675.0 7489.4 7533.4 7536.7 7539.8 7550.7 7598.9 7611.7 7613.4 7623.8 7627.8 5904.6 7234.2 7235.5 7256.9 7267.1 6455.8 6852.6 7194.7 7221.6 7226.9 7586.5 7630.2 7636.0 7641.3 7642.7 4483.8 4495.2 4502.5 4506.7 4508.0 6221.7 6908.5 7203.6 7243.5 7254.6 6715.8 6971.9 7033.0 7033.7 7044.9 6975.9 7012.8 7026.4 7029.4 7032.2 6868.3 6871.5 6871.6 6877.8 6881.3 6721.1 6986.6 7008.5 7011.7 7016.4 6624.2 6779.6 6781.6 6872.9 6902.9 14:34:15 INFO - PROCESS | 1675 | 14:34:15 INFO - PROCESS | 1675 | [#5] yui.html Cycles:180 Average:18517.07 Median:31115.03 stddev:26191.23 (84.2%) stddev-sans-first:26230.41 14:34:15 INFO - PROCESS | 1675 | Values: 666.8 673.2 750.8 763.2 772.9 14039.6 14351.4 14405.8 14406.4 14437.7 14292.6 14320.7 14423.7 14434.4 14476.0 931.4 967.3 969.2 969.8 971.9 942.2 955.1 956.4 956.9 958.0 988.4 992.6 993.0 993.5 994.1 981.4 982.4 987.2 987.7 994.8 735.4 735.8 736.4 736.9 737.7 15824.8 15896.0 15903.0 15925.7 15950.0 12477.3 12479.9 12629.2 12691.7 12914.4 10060.5 10095.6 10323.0 10625.7 10771.7 3435.9 3438.7 3449.3 3533.0 3576.4 87175.0 87840.6 88914.0 88972.6 89088.0 9243.1 9402.7 9462.3 9557.4 10140.7 21826.9 21856.3 21866.0 21889.0 21920.5 7371.6 7414.0 7468.0 7472.6 7596.9 4141.4 4197.1 4204.6 4213.2 4213.6 3599.0 3645.8 3648.3 3649.9 3650.3 653.9 660.3 664.2 668.6 674.6 501.8 533.7 589.9 595.1 614.6 7079.3 8002.4 8134.8 8250.2 8291.4 563.7 575.2 589.5 594.2 602.3 3841.8 3853.7 3875.9 3882.6 4070.1 89510.0 91418.0 92872.0 93024.5 96618.5 68220.0 75710.6 82414.6 82592.0 84649.0 68436.0 70420.3 72535.0 72580.6 73583.9 8204.1 8305.7 8502.5 8533.5 8553.7 47881.0 48170.8 48657.8 49356.0 50172.7 61615.5 64637.7 64883.4 65218.7 65608.0 10789.5 10925.8 11006.8 11121.5 11258.3 11708.9 11835.6 11855.3 11899.8 12242.4 11287.6 11440.1 11518.8 11587.8 11942.4 11568.4 11585.4 11875.5 11880.9 11895.2 11205.3 11277.7 11408.9 11541.1 11633.2 9435.6 9461.4 9466.5 9487.4 9597.9 9201.4 9587.1 9713.3 9715.8 9850.8 14:34:15 INFO - PROCESS | 1675 | -------- Summary: end -------- 14:34:15 INFO - PROCESS | 1675 | 14:34:16 INFO - TEST-INFO | 1675: exit 0 14:34:16 INFO - TEST-OK | dromaeo_css | took 1113972ms 14:34:16 INFO - TEST-START | kraken 14:34:16 INFO - operating with platform_type : mac_ 14:34:16 INFO - Initialising browser for kraken test... 14:34:16 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpSq4IKW/profile http://localhost:49270/getInfo.html) 14:34:18 INFO - PROCESS | 1683 | __metrics Screen width/height:1600/1200 14:34:18 INFO - PROCESS | 1683 | colorDepth:24 14:34:18 INFO - PROCESS | 1683 | Browser inner width/height: 1024/689 14:34:18 INFO - PROCESS | 1683 | __metrics 14:34:18 INFO - PROCESS | 1683 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:34:18 ERROR - PROCESS | 1683 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:34:19 INFO - TEST-INFO | 1683: exit 0 14:34:19 INFO - Browser initialized. 14:34:19 INFO - Running cycle 1/1 for kraken test... 14:34:19 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpSq4IKW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:34:31 INFO - PROCESS | 1685 | RSS: Main: 246865920 14:34:31 INFO - PROCESS | 1685 | 14:34:33 INFO - PROCESS | 1685 | 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) 14:34:34 INFO - PROCESS | 1685 | RSS: Main: 292933632 14:34:34 INFO - PROCESS | 1685 | 14:34:36 INFO - PROCESS | 1685 | 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) 14:34:37 INFO - PROCESS | 1685 | RSS: Main: 302911488 14:34:37 INFO - PROCESS | 1685 | 14:34:40 INFO - PROCESS | 1685 | 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) 14:34:41 INFO - PROCESS | 1685 | RSS: Main: 290885632 14:34:41 INFO - PROCESS | 1685 | 14:34:43 INFO - PROCESS | 1685 | 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) 14:34:43 INFO - PROCESS | 1685 | RSS: Main: 292061184 14:34:43 INFO - PROCESS | 1685 | 14:34:45 INFO - PROCESS | 1685 | 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) 14:34:46 INFO - PROCESS | 1685 | RSS: Main: 292024320 14:34:46 INFO - PROCESS | 1685 | 14:34:49 INFO - PROCESS | 1685 | 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) 14:34:49 INFO - PROCESS | 1685 | RSS: Main: 294686720 14:34:49 INFO - PROCESS | 1685 | 14:34:52 INFO - PROCESS | 1685 | 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) 14:34:53 INFO - PROCESS | 1685 | RSS: Main: 294912000 14:34:53 INFO - PROCESS | 1685 | 14:34:56 INFO - PROCESS | 1685 | 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) 14:34:56 INFO - PROCESS | 1685 | RSS: Main: 295448576 14:34:56 INFO - PROCESS | 1685 | 14:34:58 INFO - PROCESS | 1685 | 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) 14:34:59 INFO - PROCESS | 1685 | RSS: Main: 327745536 14:34:59 INFO - PROCESS | 1685 | 14:35:00 INFO - PROCESS | 1685 | 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) 14:35:01 INFO - PROCESS | 1685 | RSS: Main: 327876608 14:35:01 INFO - PROCESS | 1685 | 14:35:03 INFO - PROCESS | 1685 | 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) 14:35:04 INFO - PROCESS | 1685 | RSS: Main: 334618624 14:35:04 INFO - PROCESS | 1685 | 14:35:06 INFO - PROCESS | 1685 | 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) 14:35:07 INFO - PROCESS | 1685 | RSS: Main: 334614528 14:35:07 INFO - PROCESS | 1685 | 14:35:09 INFO - PROCESS | 1685 | 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) 14:35:10 INFO - PROCESS | 1685 | RSS: Main: 336101376 14:35:10 INFO - PROCESS | 1685 | 14:35:12 INFO - PROCESS | 1685 | 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) 14:35:12 INFO - PROCESS | 1685 | RSS: Main: 395689984 14:35:12 INFO - PROCESS | 1685 | 14:35:12 INFO - PROCESS | 1685 | __start_tp_report 14:35:12 INFO - PROCESS | 1685 | _x_x_mozilla_page_load 14:35:12 INFO - PROCESS | 1685 | _x_x_mozilla_page_load_details 14:35:12 INFO - PROCESS | 1685 | |i|pagename|runs| 14:35:12 INFO - PROCESS | 1685 | |0;ai-astar;113;106;109;110;110;111;116;111;113;111 14:35:12 INFO - PROCESS | 1685 | |1;audio-beat-detection;154;122;142;153;116;141;137;120;160;119 14:35:12 INFO - PROCESS | 1685 | |2;audio-dft;186;188;186;186;185;185;186;186;184;183 14:35:12 INFO - PROCESS | 1685 | |3;audio-fft;74;81;82;79;55;60;61;85;77;56 14:35:12 INFO - PROCESS | 1685 | |4;audio-oscillator;90;129;171;111;78;85;113;78;80;114 14:35:12 INFO - PROCESS | 1685 | |5;imaging-gaussian-blur;89;87;90;88;87;129;91;89;90;88 14:35:12 INFO - PROCESS | 1685 | |6;imaging-darkroom;96;96;95;97;95;96;96;97;96;95 14:35:12 INFO - PROCESS | 1685 | |7;imaging-desaturate;89;92;90;89;103;135;134;92;91;191 14:35:12 INFO - PROCESS | 1685 | |8;json-parse-financial;57;55;55;54;53;54;54;65;56;53 14:35:12 INFO - PROCESS | 1685 | |9;json-stringify-tinderbox;66;70;67;74;76;72;71;69;69;69 14:35:12 INFO - PROCESS | 1685 | |10;stanford-crypto-aes;83;82;83;83;83;81;81;82;83;83 14:35:12 INFO - PROCESS | 1685 | |11;stanford-crypto-ccm;145;111;120;131;129;126;119;135;128;118 14:35:12 INFO - PROCESS | 1685 | |12;stanford-crypto-pbkdf2;139;129;141;173;181;127;137;141;138;138 14:35:12 INFO - PROCESS | 1685 | |13;stanford-crypto-sha256-iterative;68;66;67;68;68;71;87;100;97;67 14:35:12 INFO - PROCESS | 1685 | __end_tp_report 14:35:12 INFO - PROCESS | 1685 | __start_cc_report 14:35:12 INFO - PROCESS | 1685 | _x_x_mozilla_cycle_collect,1207 14:35:12 INFO - PROCESS | 1685 | __end_cc_report 14:35:12 INFO - PROCESS | 1685 | __startTimestamp1458682512620__endTimestamp 14:35:12 INFO - PROCESS | 1685 | 14:35:12 INFO - PROCESS | 1685 | ------- Summary: start ------- 14:35:12 INFO - PROCESS | 1685 | Number of tests: 14 14:35:12 INFO - PROCESS | 1685 | 14:35:12 INFO - PROCESS | 1685 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:2.67 (2.4%) stddev-sans-first:2.73 14:35:12 INFO - PROCESS | 1685 | Values: 113.0 106.0 109.0 110.0 110.0 111.0 116.0 111.0 113.0 111.0 14:35:12 INFO - PROCESS | 1685 | 14:35:12 INFO - PROCESS | 1685 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:141.50 stddev:16.30 (11.5%) stddev-sans-first:15.99 14:35:12 INFO - PROCESS | 1685 | Values: 154.0 122.0 142.0 153.0 116.0 141.0 137.0 120.0 160.0 119.0 14:35:12 INFO - PROCESS | 1685 | 14:35:12 INFO - PROCESS | 1685 | [#2] audio-dft Cycles:10 Average:185.50 Median:186.00 stddev:1.35 (0.7%) stddev-sans-first:1.42 14:35:12 INFO - PROCESS | 1685 | Values: 186.0 188.0 186.0 186.0 185.0 185.0 186.0 186.0 184.0 183.0 14:35:12 INFO - PROCESS | 1685 | 14:35:12 INFO - PROCESS | 1685 | [#3] audio-fft Cycles:10 Average:71.00 Median:78.00 stddev:11.68 (15.0%) stddev-sans-first:12.34 14:35:12 INFO - PROCESS | 1685 | Values: 74.0 81.0 82.0 79.0 55.0 60.0 61.0 85.0 77.0 56.0 14:35:12 INFO - PROCESS | 1685 | 14:35:12 INFO - PROCESS | 1685 | [#4] audio-oscillator Cycles:10 Average:104.90 Median:78.00 stddev:29.48 (37.8%) stddev-sans-first:30.77 14:35:12 INFO - PROCESS | 1685 | Values: 90.0 129.0 171.0 111.0 78.0 85.0 113.0 78.0 80.0 114.0 14:35:12 INFO - PROCESS | 1685 | 14:35:12 INFO - PROCESS | 1685 | [#5] imaging-gaussian-blur Cycles:10 Average:92.80 Median:89.00 stddev:12.79 (14.4%) stddev-sans-first:13.49 14:35:12 INFO - PROCESS | 1685 | Values: 89.0 87.0 90.0 88.0 87.0 129.0 91.0 89.0 90.0 88.0 14:35:12 INFO - PROCESS | 1685 | 14:35:12 INFO - PROCESS | 1685 | [#6] imaging-darkroom Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 14:35:12 INFO - PROCESS | 1685 | Values: 96.0 96.0 95.0 97.0 95.0 96.0 96.0 97.0 96.0 95.0 14:35:12 INFO - PROCESS | 1685 | 14:35:12 INFO - PROCESS | 1685 | [#7] imaging-desaturate Cycles:10 Average:110.60 Median:89.50 stddev:33.50 (37.4%) stddev-sans-first:34.60 14:35:12 INFO - PROCESS | 1685 | Values: 89.0 92.0 90.0 89.0 103.0 135.0 134.0 92.0 91.0 191.0 14:35:12 INFO - PROCESS | 1685 | 14:35:12 INFO - PROCESS | 1685 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:3.53 (6.4%) stddev-sans-first:3.71 14:35:12 INFO - PROCESS | 1685 | Values: 57.0 55.0 55.0 54.0 53.0 54.0 54.0 65.0 56.0 53.0 14:35:12 INFO - PROCESS | 1685 | 14:35:12 INFO - PROCESS | 1685 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.50 stddev:3.06 (4.3%) stddev-sans-first:2.82 14:35:12 INFO - PROCESS | 1685 | Values: 66.0 70.0 67.0 74.0 76.0 72.0 71.0 69.0 69.0 69.0 14:35:12 INFO - PROCESS | 1685 | 14:35:12 INFO - PROCESS | 1685 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:0.84 (1.0%) stddev-sans-first:0.87 14:35:12 INFO - PROCESS | 1685 | Values: 83.0 82.0 83.0 83.0 83.0 81.0 81.0 82.0 83.0 83.0 14:35:12 INFO - PROCESS | 1685 | 14:35:12 INFO - PROCESS | 1685 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:128.50 stddev:9.74 (7.6%) stddev-sans-first:7.59 14:35:12 INFO - PROCESS | 1685 | Values: 145.0 111.0 120.0 131.0 129.0 126.0 119.0 135.0 128.0 118.0 14:35:12 INFO - PROCESS | 1685 | 14:35:12 INFO - PROCESS | 1685 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.40 Median:140.00 stddev:17.91 (12.8%) stddev-sans-first:18.89 14:35:12 INFO - PROCESS | 1685 | Values: 139.0 129.0 141.0 173.0 181.0 127.0 137.0 141.0 138.0 138.0 14:35:12 INFO - PROCESS | 1685 | 14:35:12 INFO - PROCESS | 1685 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.90 Median:68.00 stddev:13.40 (19.7%) stddev-sans-first:13.91 14:35:12 INFO - PROCESS | 1685 | Values: 68.0 66.0 67.0 68.0 68.0 71.0 87.0 100.0 97.0 67.0 14:35:12 INFO - PROCESS | 1685 | -------- Summary: end -------- 14:35:12 INFO - PROCESS | 1685 | 14:35:13 INFO - TEST-INFO | 1685: exit 0 14:35:13 INFO - TEST-OK | kraken | took 57071ms 14:35:13 INFO - SUITE-END | took 1171s 14:35:13 INFO - Completed test suite (00:19:31) 14:35:13 INFO - javascript benchmark 14:35:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3398.7620866539346, 3463.619001909791, 3466.6360032196635, 3485.8082805445706, 3537.1687653401445, 5514.0901751211, 5549.667019978804, 5580.023495888218, 5629.943700562998, 5633.746481408336, 4561.863144105674, 5493.258410114633, 5542.584306177033, 5546.667199967995, 5572.7770889164385, 5029.647924645267, 5056.898862022757, 5087.465816089294, 5143.408508021569, 5146.485351464842, 5086.694798312114, 5093.745312734367, 5150.896982060356, 5153.407358153804, 5168.61235407346, 5125.974370128144, 5146.794128234885, 5155.871103222412, 5182.559482443978, 5186.377634683843, 5168.741562921858, 5222.242774797652, 5236.633435659505, 5237.47625237477, 5287.814926477555, 4096.836126554934, 4989.725565093919, 5114.41184263807, 5126.846194614168, 5154.433012368637, 5311.7344132793205, 5454.154606036071, 5465.289512363407, 5473.726313684339, 5534.08687566551, 6069.969650151721, 6082.391760823926, 6096.664683442409, 6097.268327800648, 6105.847353816146, 6051.364606716319, 6139.048447490602, 6166.568340216187, 6171.074338849164, 6178.814635560941, 5754.942450575482, 5772.595918285764, 5784.305883294031, 5788.131780232999, 5823.4467725566, 6132.877342453126, 6205.100260462208, 6212.627242365473, 6213.65824879636, 6220.377962203744, 5863.882722345529, 5981.162637230791, 6052.939470605237, 6055.455009049207, 6086.087086936995, 6139.188686267213, 6164.260288765377, 6190.81427557174, 6197.225346831646, 6197.845053873599, 6069.15031895535, 6112.449879510777, 6124.816255512342, 6145.170401995673, 6163.537734669918, 5964.7315870785915, 6068.21113255274, 6069.453749162508, 6128.472568454217, 6143.696113957266, 4760.59534939534, 4778.092162489116, 4783.473817880031, 4806.255030470283, 4823.686460380134, 4079.3065178919655, 4312.223799716018, 4313.827446902152, 4326.978365108154, 4375.321825117112, 5365.624406291522, 5442.619016668875, 5453.890922181534, 5462.262594549765, 5475.479829416199, 6146.323904370515, 6205.2553693557065, 6206.596571222856, 6213.347598502182, 6221.5333849960525, 5510.201020851954, 5556.972215138899, 5561.749721262553, 5562.054450743383, 5591.217229587861, 5158.3552055993005, 5194.844154675366, 5292.417834038252, 5309.7079660618265, 5310.283111779938, 6155.35368786271, 6218.751249950042, 6222.315545289924, 6228.750849966042, 6231.875362492634, 6164.075388691732, 6166.599171053867, 6167.691615419121, 6175.2589689237575, 6176.073588961692, 6146.985747351637, 6156.599821011799, 6181.84545386351, 6184.845378865564, 6246.969250073687, 6065.0, 6099.542534309856, 6119.816405507842, 6139.171211886517, 6139.631622102688, 6137.011896361508, 6189.876202475835, 6191.597546159485, 6196.566240363131, 6230.190075290183, 5783.508401785727, 5909.70451477433, 5913.319968203539, 5917.319508256605, 6026.020547774785, 5858.502027327725, 5933.050711886078, 5934.673592952429, 5936.139259807217, 5944.464998150187, 5095.974520127375, 5660.150977353265, 5801.709914504174, 5808.94191058084, 5812.447817457335, 4917.237828136645, 5778.913316300343, 5933.495652869382, 6003.309619393651, 6110.175126357884, 5772.6536407815665, 5868.061110222344, 5928.9407105928385, 5939.673317967553, 6005.609635373687], "unit": "score", "name": "dojo.html", "value": 5580.430328929374}, {"lowerIsBetter": false, "replicates": [456.6118799020833, 472.5487159762427, 578.8423153692614, 624.1137584629826, 632.5919781740779, 33907.32185356291, 38244.0, 38305.04237394067, 38394.616053839454, 38522.0, 39282.82151535452, 39963.60036399635, 39963.800180999126, 40014.59985400145, 40075.59735409261, 9288.814223715539, 9528.761780955498, 9544.61821527138, 9572.32993690442, 9574.186194173504, 9369.48467834269, 9643.373180743229, 9651.083147101013, 9652.806943861118, 9655.420674759502, 9600.471974041426, 9675.371100878456, 9684.75788105296, 9697.75755606112, 9710.9514452428, 9563.378380405285, 9654.903450965507, 9670.613175472972, 9677.516124193762, 9695.70912872615, 9477.810443791155, 9620.615175392975, 9629.470379129145, 9629.711108666752, 9630.27772917034, 38160.80919595412, 38594.61405385938, 38607.8417647471, 38636.420453693216, 38779.030524236834, 3242.093545629835, 3296.9505457417918, 3634.582023067328, 3749.887503374903, 3892.4550562921213, 27929.581056284173, 28702.71297287042, 29219.0, 29327.973520926666, 29345.559816602767, 2210.823134149264, 2720.197541725176, 2746.148693904896, 2796.4826507096254, 2814.8592570371397, 496177.0, 498039.9999999964, 499919.0, 500055.0, 500153.0, 45797.77101114473, 46670.0, 46765.76617116893, 59762.70118649379, 61599.768004639656, 46447.07105857864, 46676.29985550219, 46736.76631616888, 46791.5320846794, 46802.531974680496, 15761.369545218064, 15959.760603590956, 15968.840311596967, 15980.76028859568, 15983.920080399523, 12680.746385072247, 12754.80867786984, 12762.61712148637, 12773.61679149627, 12782.552610658582, 15153.393864245307, 15157.362233064207, 15196.088234705952, 15198.088114713153, 15301.693966120616, 6387.872242555123, 6539.771108011292, 6581.934180658228, 6595.208574971034, 6607.57050791697, 971.3055165556661, 989.6882482018141, 1012.3268026762121, 1069.3637285815082, 1109.8834622364536, 29839.701602984125, 29925.85037074801, 30458.84770576133, 30721.231969200948, 30802.0, 1074.2641290715728, 1146.1747541769912, 1184.9881501184877, 1199.5561642192445, 1295.313483853559, 13030.58934097195, 15158.166300853338, 15268.541943741706, 15410.6147346315, 15869.52391428236, 482376.0, 520658.396708014, 521261.7558385438, 521837.0, 521843.39078304364, 57254.427455725745, 59241.0, 59351.10973335403, 59424.70287648534, 59544.40455595475, 1378.9793153102712, 1384.8199734034713, 1478.7855760914608, 1492.4179569967505, 1521.6652336486177, 22386.440338991655, 29125.563116552847, 29154.271143221587, 29966.70033299639, 29972.70027299699, 45152.774236129924, 45206.54793452155, 45616.54383456123, 45630.0, 45638.08723825571, 336081.0, 337041.0, 337127.0, 338100.0, 338563.0, 34534.48198276978, 34948.30103397969, 42990.0, 44745.88135296643, 44817.87955301144, 43567.782161088995, 43806.56193438025, 44077.33883991807, 44283.77858110689, 44716.77641611901, 36231.27537449289, 36787.264254714224, 37033.81483092675, 37402.0, 37747.245055099294, 31077.446127693074, 35843.64156358403, 36334.454983175805, 36743.0, 37599.43600846044, 36501.0, 36543.81728091343, 37030.8148459256, 37441.251174975805, 37765.81117094397, 32147.67852321447, 32390.028299151065, 32510.187245319055, 32617.673823262412, 32748.017559473254, 24164.63753043741, 24543.38641533976, 24556.01775928943, 24586.38534036592, 24804.50390992134], "unit": "score", "name": "ext.html", "value": 19083.46394954483}, {"lowerIsBetter": false, "replicates": [363.6399964035604, 363.7090327737809, 365.23483302481293, 375.62625187938005, 376.54062044305954, 19236.519087022833, 19956.201751929922, 21287.893560532175, 21351.466213344673, 21351.67972480414, 20428.89785551074, 20474.976251187454, 21230.25694100707, 21260.14959401626, 21374.931253437306, 4295.377170310303, 6026.246719160105, 6047.092936059582, 6075.969620151893, 6076.3316035236085, 5475.808346707866, 5744.971275143618, 5746.367899531048, 5752.5110365618975, 5837.562182836283, 4838.830640927568, 5717.371089180187, 5735.827925162252, 5745.942540574582, 5746.712664366786, 5723.17014032967, 6073.7874174403905, 6172.22847144107, 6228.37716228378, 6231.87536249277, 5584.46947539983, 5606.159076138571, 5614.073677843151, 5616.887662246773, 5620.971895140539, 23530.0, 23832.64251036236, 24536.0, 24804.751952480605, 24856.005759769767, 1930.4305229957197, 2101.77931317211, 2180.8146307563875, 2244.8540844845033, 2741.876615552305, 9743.805123897482, 9873.555689993897, 9998.350107243006, 10011.949940250252, 10084.445355505444, 1739.765131707216, 1793.5695433095964, 1800.9099545022696, 1817.270023485489, 1836.7795864496345, 103410.0, 104279.0, 104324.99999999924, 104849.99999999924, 108217.45891270573, 9931.304808663468, 10869.804321524625, 11212.66362009141, 11271.718207044725, 11713.238639488405, 13756.931215343859, 13807.861921380658, 13916.930415347859, 13917.23455209953, 13940.721185576233, 8440.029396619344, 8451.577421128919, 8531.10423405546, 8658.220760131619, 8775.956120219358, 8510.70212542558, 8702.825943481095, 8748.34387420946, 8802.86795698065, 8874.733757987271, 4514.7291162530355, 4579.702319349231, 4596.47140578831, 4607.262837945913, 4628.83799067031, 1907.5326544996287, 1938.7220016480578, 1949.83426408754, 1962.4701330640646, 1964.5383334916282, 835.8579041562949, 879.8944126704837, 924.4822899176482, 1004.929654924163, 1012.3829061519156, 16659.66722662184, 20565.69151462729, 20852.12330890197, 20853.37439876806, 20954.0570674317, 938.6808485115093, 980.9313348065709, 985.8422652375585, 1001.1840350114634, 1001.6143784642965, 10873.510692018877, 11129.162063673873, 11178.329300242012, 11200.831987520194, 11212.822653621415, 582586.0, 591872.0, 619367.0, 631496.0, 638797.0, 115543.0, 118498.0, 118616.62766744789, 119032.0, 119141.0, 1034.5499707627055, 1038.1746511523206, 1051.9000694933968, 1056.7569459024467, 1057.1384321777728, 18355.908220458812, 18514.98167600795, 18583.628327433104, 18675.626487469905, 18692.34576789806, 41236.96907577335, 51954.480455194964, 53502.0, 53701.19448208202, 53977.46022539724, 75150.62424687842, 75692.0, 75979.86030209663, 76459.0, 76984.0, 7783.532988020737, 10592.841107383549, 10940.445714512436, 11123.0, 11155.888441115485, 8605.612747426507, 8630.870536941826, 8764.21122099014, 8775.034746178044, 9181.035991221093, 7718.382529397747, 7843.411674147632, 7864.764057078297, 7866.370690344645, 8117.878231826646, 7584.810379740551, 7712.228777122243, 7857.017872765904, 7887.053553573378, 8012.959935200287, 7722.173641474079, 7933.761987140395, 7939.166387529226, 7956.085050219299, 8381.664733410595, 10439.060484556123, 10748.731281718019, 11337.603183888854, 11374.829377559508, 11618.825717614412, 10179.98200179976, 10277.383356998604, 10623.521941512496, 11317.094632429222, 11491.080713543064], "unit": "score", "name": "jquery.html", "value": 9252.345511486772}, {"lowerIsBetter": false, "replicates": [1470.2207829850183, 1602.7195240832855, 1643.1537758054603, 1936.3126090237965, 2053.28238077795, 8075.273225409712, 8559.614817333219, 8766.95616521918, 8779.209871111607, 8783.209511143996, 7114.750983715571, 8760.518171500566, 8877.289816814655, 8887.377883548153, 8901.599428025738, 2168.2844661261747, 2402.3994001499627, 2479.8636075015866, 2488.2582192465256, 2503.486785209028, 2496.3509487533283, 2500.612405077216, 2510.6736124303816, 2515.019142534413, 2523.1169090818157, 2420.1166574200465, 2472.8763561821925, 2495.5258500884865, 2496.1263557754824, 2498.7001559812848, 2401.9023784716123, 2422.994457300218, 2482.4042229864795, 2485.5898776701824, 2489.65144879717, 2431.0761910474084, 2473.9628905566433, 2479.2810085075307, 2480.218731099698, 2485.3413845331, 8949.955250223773, 9030.909690903138, 9031.503267320295, 9037.502937338444, 9049.77375565616, 5511.641743286714, 5594.1608758686525, 5628.493435590816, 5631.690257035862, 5646.915296270559, 2994.2065352681557, 3588.946165807515, 3759.868404605853, 3764.0401697567218, 3793.3172029034763, 1053.3048188195753, 1071.860658114448, 1079.854219680341, 1086.6902932664232, 1088.5373716170675, 12275.754484910341, 12293.0, 12321.199122057127, 12333.013358931265, 12336.321502317369, 4073.8796830871747, 4917.188663870493, 5019.0463811875625, 5029.5724863386295, 5055.8988820223385, 10194.388336699822, 10283.023112804272, 10284.845727314096, 10289.94855025735, 10304.742381440374, 5573.164025396223, 5613.859653508695, 5614.29821272341, 5622.634528755618, 5625.212470254168, 4476.060027394218, 4590.609798167126, 4969.527894849984, 5068.923966140511, 5074.797008119708, 3942.5860284669698, 4038.172174704179, 4057.7159598827798, 4079.85720499787, 4108.958910410857, 1325.370449036719, 1337.4048548396065, 1347.0907137682025, 1350.7771217748962, 1356.1795113955914, 1210.6912737251944, 1340.1690951610065, 1389.4442223110836, 1390.5550223928449, 1393.2267591486823, 8329.916700833035, 8385.161483851565, 8400.117987611335, 8414.621342039623, 8427.873581896276, 511.9155339368962, 524.5384062025394, 526.0714838310386, 528.355406404194, 531.5083547718423, 4995.250712393097, 6232.470240029557, 6242.09489624002, 6262.718177682015, 6267.6866156692895, 10223.284370094021, 10485.842712359321, 10616.734581635521, 10623.628173013907, 10638.414887181125, 10238.53926573306, 10381.84427233592, 10495.055445009986, 10504.632337868137, 10510.369377837354, 8239.217274358927, 8287.875681864776, 8343.290820280345, 8361.247487726134, 8440.282575981111, 8067.556284404414, 8137.471064380797, 8142.47073940192, 8207.589620518831, 8381.078081410918, 8074.677012919417, 9803.558839852367, 9850.0, 9890.456024918698, 9901.950490247502, 10159.390436573534, 10207.285490015627, 10237.283390162616, 10238.948805255926, 10373.377597344184, 6885.827854303682, 7216.278372162742, 7521.736739214101, 7611.467197296136, 7757.844843102994, 8378.120297368689, 8406.789830254293, 8449.87325190135, 8457.534835584102, 8464.915350846413, 6016.21789167423, 7320.231375705474, 7404.518706284074, 7550.395968322411, 7551.509151905108, 7218.747343843151, 7285.963570182115, 7290.890636640561, 7324.523905946096, 7345.971563981154, 7644.3120119187315, 7754.147043825287, 7768.689252429839, 7770.728024519115, 7788.727394541391, 6940.687669054803, 6961.338672826073, 7032.578045317297, 7036.944458331292, 7042.0493233412835, 7090.1491820979745, 7160.964195178991, 7206.2793720627515, 7226.819329516804, 7234.674439650334], "unit": "score", "name": "mootools.html", "value": 4892.795042189382}, {"lowerIsBetter": false, "replicates": [318.2521075472639, 324.982125983071, 330.0066798935204, 330.0971842012095, 332.26735049216495, 6576.539642225046, 6632.635205063725, 6645.966770166148, 6672.866542669156, 6687.465002799777, 6481.222253329607, 6535.3137920518375, 6554.2462616799085, 6560.0, 6567.737290508386, 4615.65382596305, 4680.812767489297, 4756.07256584966, 4771.761411929407, 4850.078485087831, 4784.808607655689, 4799.712017278975, 4820.469748327681, 4843.757812109398, 4847.975760121194, 4761.690490118149, 4784.473707892129, 4817.51824817519, 4818.421789385278, 4822.156122678535, 4574.19951508488, 4648.48866624671, 4759.690620109682, 4767.0, 4818.132736107516, 4058.4723985881647, 4076.510818701745, 4077.041895154636, 4078.5717499662405, 4098.610631989956, 6252.0, 6265.655388953605, 6285.685715714196, 6298.685065746694, 6314.557980941336, 5613.663180209201, 5628.9305032043785, 5642.520385767215, 5649.23735295734, 5656.123300888369, 6924.376806087426, 6929.029935808991, 6929.72281108755, 6937.653117344163, 6949.861002779967, 4454.28731402974, 4514.480834703985, 4591.678582499227, 4621.838235661769, 4629.513901040376, 7231.819204519877, 7293.030881661922, 7294.671739771723, 7312.8171795705, 7319.817004574875, 4672.112298663243, 4675.602573781199, 4681.204195286809, 4683.431050598019, 4700.929486057712, 4277.401163837066, 4420.585412667915, 4755.619550436026, 4763.7141771493825, 4780.784864681028, 5606.766511367493, 5613.298337707786, 5636.2954630671165, 5640.520555752807, 5644.8306550803545, 6610.96694516534, 6889.724411023603, 6981.511294209458, 6986.371226589631, 6991.545549539263, 1330.4744625872727, 1584.9366025359086, 1592.0606841963297, 1607.7829493018294, 1608.9863386066936, 887.6538150121457, 1007.8309161372919, 1017.7710015246511, 1022.9437380943971, 1025.5333823110616, 6234.657093859882, 6306.590071645328, 6387.073874288202, 6405.455536279375, 6444.903326450107, 7232.927670723226, 7258.165310989199, 7276.454265930077, 7278.308560686726, 7283.817904552428, 6429.774957876545, 6430.8103000944975, 6432.678366081677, 6437.130987316746, 6456.322086180978, 3799.1831756172555, 3836.7506112103183, 3844.2503711776494, 3848.5574158972076, 3862.3627101528496, 7293.927060729431, 7578.886316705254, 7603.9619801900635, 7642.694292228249, 7675.002249707502, 7489.3634041106025, 7533.4349923755935, 7536.7362142324755, 7539.811504712426, 7550.6602202901, 7598.924010759822, 7611.733589324347, 7613.352865006425, 7623.847523049508, 7627.809304767426, 5904.5866789326055, 7234.16807067194, 7235.529690570306, 7256.854862902606, 7267.127944646465, 6455.7740479083, 6852.588844669336, 7194.748183813542, 7221.602811845399, 7226.927730722836, 7586.544807311579, 7630.236976302325, 7636.045494313211, 7641.2740789624895, 7642.694292228249, 4483.820647174077, 4495.168393847149, 4502.527234640315, 4506.662000350052, 4508.0, 6221.688915554114, 6908.507736349514, 7203.639818008974, 7243.45674074436, 7254.637268136677, 6715.832104197239, 6971.860562788817, 7032.964835175791, 7033.683484243119, 7044.929550704427, 6975.930240697731, 7012.824679383056, 7026.367626913602, 7029.3673569379, 7032.156141263081, 6868.278830722902, 6871.5189936703955, 6871.553349032297, 6877.828054298682, 6881.277465866012, 6721.126253587003, 6986.6157361343585, 7008.528209076151, 7011.6844741985715, 7016.403605693369, 6624.205095388585, 6779.593224406552, 6781.627010514272, 6872.862542749017, 6902.896456553256], "unit": "score", "name": "prototype.html", "value": 5095.27818260956}, {"lowerIsBetter": false, "replicates": [666.8366250268685, 673.1787219592097, 750.7560042986028, 763.1795819494043, 772.9072511298644, 14039.578812635624, 14351.35418906149, 14405.783913241283, 14406.423743050278, 14437.711245775105, 14292.642683932881, 14320.713585728305, 14423.711525769479, 14434.42262309509, 14475.98668093234, 931.3573634192419, 967.3325405470238, 969.2246203037541, 969.8157350103493, 971.8736564246637, 942.1708896171359, 955.126059655418, 956.4213650741306, 956.8612551180074, 958.0467434902282, 988.3723835364524, 992.5979978108877, 992.9821932519153, 993.4734590666958, 994.0705440413237, 981.40134517944, 982.4400091947592, 987.1707765476998, 987.6740675577042, 994.7910938702881, 735.4410647907575, 735.808689740666, 736.3593673504085, 736.9410447164214, 737.7196665267218, 15824.76262856058, 15896.0, 15903.045817251003, 15925.681486370207, 15950.042997420192, 12477.251364918135, 12479.875201247962, 12629.24224546521, 12691.682707932283, 12914.411916075798, 10060.547275372626, 10095.596176152945, 10322.967703229691, 10625.681229563048, 10771.676849694522, 3435.914102147441, 3438.673326034023, 3449.2847048322815, 3532.9646703532894, 3576.356255873942, 87175.0, 87840.56079719625, 88914.0, 88972.55513722455, 89088.0, 9243.121903419164, 9402.717918462457, 9462.29032822541, 9557.378770379903, 10140.695779126638, 21826.908654567207, 21856.344309670734, 21866.016029278722, 21889.0, 21920.45198870041, 7371.631418429164, 7413.962930185422, 7468.0, 7472.626368681545, 7596.886046709304, 4141.358089496133, 4197.118605092904, 4204.600562946515, 4213.1994920965535, 4213.599708027732, 3598.9640103599154, 3645.799481028569, 3648.3432982062955, 3649.8540058397366, 3650.3064417760543, 653.8986457099157, 660.2802944790202, 664.1697877652933, 668.5888178770022, 674.6019848289533, 501.7756673716121, 533.66112518551, 589.8613825750945, 595.1013968906982, 614.6035806904522, 7079.327463890922, 8002.439829212016, 8134.75595732129, 8250.216229458192, 8291.419600627898, 563.7125066216178, 575.2119596153296, 589.4812564942823, 594.191899017336, 602.2832828933555, 3841.7887016213817, 3853.7109716771356, 3875.9418608720894, 3882.6117388261514, 4070.1452694934396, 89510.0, 91418.0, 92872.0, 93024.53487732518, 96618.51690741502, 68220.0, 75710.62144689242, 82414.58792705998, 82592.0, 84649.0, 68436.0, 70420.29579704137, 72535.0, 72580.63709681417, 73583.89624155642, 8204.097549269694, 8305.709300174465, 8502.489850608983, 8533.53065581399, 8553.657853685783, 47881.0, 48170.759146204044, 48657.756711216214, 49356.0, 50172.749136255545, 61615.459613508225, 64637.67681161564, 64883.35116648962, 65218.67390663016, 65608.0, 10789.514471848943, 10925.83611245816, 11006.779864402828, 11121.499532520895, 11258.324500529994, 11708.941455292668, 11835.644930652094, 11855.34795586251, 11899.821502677294, 12242.387880606113, 11287.604933827277, 11440.141989350666, 11518.769624607294, 11587.8261826071, 11942.402879856147, 11568.363739994382, 11585.362805045803, 11875.456190695155, 11880.881191187977, 11895.167338286237, 11205.271657342246, 11277.71805704864, 11408.94295528517, 11541.076713863038, 11633.185677002528, 9435.622575097193, 9461.38500997433, 9466.479343636167, 9487.383320084173, 9597.856032159383, 9201.401908876169, 9587.137157655845, 9713.271504637321, 9715.805683886425, 9850.802983940137], "unit": "score", "name": "yui.html", "value": 7002.338391768591}], "name": "dromaeo_css", "value": 7457.555249009369}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 106.0, 109.0, 110.0, 110.0, 111.0, 116.0, 111.0, 113.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [154.0, 122.0, 142.0, 153.0, 116.0, 141.0, 137.0, 120.0, 160.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 136.4}, {"lowerIsBetter": true, "replicates": [186.0, 188.0, 186.0, 186.0, 185.0, 185.0, 186.0, 186.0, 184.0, 183.0], "unit": "score", "name": "audio-dft", "value": 185.5}, {"lowerIsBetter": true, "replicates": [74.0, 81.0, 82.0, 79.0, 55.0, 60.0, 61.0, 85.0, 77.0, 56.0], "unit": "score", "name": "audio-fft", "value": 71.0}, {"lowerIsBetter": true, "replicates": [90.0, 129.0, 171.0, 111.0, 78.0, 85.0, 113.0, 78.0, 80.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 104.9}, {"lowerIsBetter": true, "replicates": [89.0, 87.0, 90.0, 88.0, 87.0, 129.0, 91.0, 89.0, 90.0, 88.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 97.0, 95.0, 96.0, 96.0, 97.0, 96.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 95.9}, {"lowerIsBetter": true, "replicates": [89.0, 92.0, 90.0, 89.0, 103.0, 135.0, 134.0, 92.0, 91.0, 191.0], "unit": "score", "name": "imaging-desaturate", "value": 110.6}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 55.0, 54.0, 53.0, 54.0, 54.0, 65.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [66.0, 70.0, 67.0, 74.0, 76.0, 72.0, 71.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.3}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 83.0, 83.0, 83.0, 81.0, 81.0, 82.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [145.0, 111.0, 120.0, 131.0, 129.0, 126.0, 119.0, 135.0, 128.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.2}, {"lowerIsBetter": true, "replicates": [139.0, 129.0, 141.0, 173.0, 181.0, 127.0, 137.0, 141.0, 138.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.4}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 67.0, 68.0, 68.0, 71.0, 87.0, 100.0, 97.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.9}], "name": "kraken", "value": 1462.9000000000003}]} 14:35:13 INFO - Return code: 0 14:35:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:35:13 ERROR - # TBPL SUCCESS # 14:35:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:35:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:35:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:35:13 INFO - 2016-03-22 14:35:13.896 screenresolution[1689:10112] starting screenresolution argv=screenresolution get 14:35:13 INFO - 2016-03-22 14:35:13.898 screenresolution[1689:10112] Display 0: 1600x1200x32@60 14:35:13 INFO - 2016-03-22 14:35:13.903 screenresolution[1690:10115] starting screenresolution argv=screenresolution list 14:35:13 INFO - Available Modes on Display 0 14:35:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:35:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:35:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:35:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:35:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:35:14 INFO - Intel Iris: 14:35:14 INFO - Chipset Model: Intel Iris 14:35:14 INFO - Type: GPU 14:35:14 INFO - Bus: Built-In 14:35:14 INFO - VRAM (Dynamic, Max): 1536 MB 14:35:14 INFO - Vendor: Intel (0x8086) 14:35:14 INFO - Device ID: 0x0a2e 14:35:14 INFO - Revision ID: 0x0009 14:35:14 INFO - Displays: 14:35:14 INFO - Display: 14:35:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:35:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:35:14 INFO - Display Serial Number: 1600x1200 60 14:35:14 INFO - Main Display: Yes 14:35:14 INFO - Mirror: Off 14:35:14 INFO - Online: Yes 14:35:14 INFO - Rotation: Supported 14:35:14 INFO - Return code: 0 14:35:14 INFO - Running post-action listener: _resource_record_post_action 14:35:14 INFO - Running post-run listener: _resource_record_post_run 14:35:15 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 34659840; Write bytes: 705807872; Read time: 363; Write time: 1828 14:35:15 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 402747904; Write bytes: 404874240; Read time: 31520; Write time: 719 14:35:15 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 32878080; Write bytes: 299926016; Read time: 346; Write time: 1105 14:35:15 INFO - Running post-run listener: _upload_blobber_files 14:35:15 INFO - Blob upload gear active. 14:35:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:35:15 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 14:35:15 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:35:15 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:35:16 INFO - (blobuploader) - INFO - Open directory for files ... 14:35:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:35:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:35:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:35:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:35:19 INFO - (blobuploader) - INFO - Done attempting. 14:35:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:35:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:35:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:35:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:35:22 INFO - (blobuploader) - INFO - Done attempting. 14:35:22 INFO - (blobuploader) - INFO - Iteration through files over. 14:35:22 INFO - Return code: 0 14:35:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:35:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:35:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/174bcd31f791c53be7572bf706505a4b524483cae060829576b7223588ab186e5cf6f7ca25d1eaf205c41762aa530c1d1b708e8bda57c9f36f5b2549664906e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ebbe1775bf264d83a35cb4e0be5dac0f468af014db23b6c4781d5c6223f8303b2fde96faecd282c7572b8ea9e88922a4741dcda2a4323aed80bbf930c4906d1"} 14:35:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:35:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:35:22 INFO - Contents: 14:35:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/174bcd31f791c53be7572bf706505a4b524483cae060829576b7223588ab186e5cf6f7ca25d1eaf205c41762aa530c1d1b708e8bda57c9f36f5b2549664906e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ebbe1775bf264d83a35cb4e0be5dac0f468af014db23b6c4781d5c6223f8303b2fde96faecd282c7572b8ea9e88922a4741dcda2a4323aed80bbf930c4906d1"} 14:35:22 INFO - Running post-run listener: copy_logs_to_upload_dir 14:35:22 INFO - Copying logs to upload dir... 14:35:22 INFO - mkdir: /builds/slave/test/build/upload/logs 14:35:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1366.980911 ========= master_lag: 0.24 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 47 secs) (at 2016-03-22 14:35:22.541628) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-22 14:35:22.545883) ========= 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.C0VbIPbPfw/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.yFkNcc8kxp/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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/Fx-Team/sha512/174bcd31f791c53be7572bf706505a4b524483cae060829576b7223588ab186e5cf6f7ca25d1eaf205c41762aa530c1d1b708e8bda57c9f36f5b2549664906e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ebbe1775bf264d83a35cb4e0be5dac0f468af014db23b6c4781d5c6223f8303b2fde96faecd282c7572b8ea9e88922a4741dcda2a4323aed80bbf930c4906d1"} build_url:https://queue.taskcluster.net/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011041 build_url: 'https://queue.taskcluster.net/v1/task/ZNKZF2JVQViTbr8SP5BvxA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/174bcd31f791c53be7572bf706505a4b524483cae060829576b7223588ab186e5cf6f7ca25d1eaf205c41762aa530c1d1b708e8bda57c9f36f5b2549664906e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ebbe1775bf264d83a35cb4e0be5dac0f468af014db23b6c4781d5c6223f8303b2fde96faecd282c7572b8ea9e88922a4741dcda2a4323aed80bbf930c4906d1"}' ========= master_lag: 0.20 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-22 14:35:22.756762) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 14:35:22.757116) ========= 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.C0VbIPbPfw/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.yFkNcc8kxp/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.004964 ========= master_lag: 0.40 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 14:35:23.162891) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-22 14:35:23.163196) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-22 14:35:23.170767) ========= ========= Total master_lag: 16.47 =========