builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0165 starttime: 1456508633.19 results: success (0) buildid: 20160226075831 builduid: 250d750ff3424a2ab12fb2216e496599 revision: 9e162af63f4c9772c7a63cfd8e1d96000109aaad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 09:43:53.193645) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 09:43:53.198094) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 09:43:53.198478) ========= 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.XdoLjpefIM/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.WxwYKcOJmy/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.005653 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 09:43:53.222147) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 09:43:53.222450) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 09:43:53.238901) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 09:43:53.239288) ========= 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.XdoLjpefIM/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.WxwYKcOJmy/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.005550 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 09:43:53.288132) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 09:43:53.288443) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 09:43:53.288827) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 09:43:53.289145) ========= 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.XdoLjpefIM/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.WxwYKcOJmy/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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-02-26 09:43:53-- 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% 36.0M=0s 2016-02-26 09:43:53 (36.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.210912 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 09:43:53.515232) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 09:43:53.515599) ========= 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.XdoLjpefIM/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.WxwYKcOJmy/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.026392 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 09:43:53.563798) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-26 09:43:53.564135) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9e162af63f4c9772c7a63cfd8e1d96000109aaad --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 9e162af63f4c9772c7a63cfd8e1d96000109aaad --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XdoLjpefIM/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.WxwYKcOJmy/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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-02-26 09:43:53,648 truncating revision to first 12 chars 2016-02-26 09:43:53,648 Setting DEBUG logging. 2016-02-26 09:43:53,648 attempt 1/10 2016-02-26 09:43:53,648 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9e162af63f4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-26 09:43:54,747 unpacking tar archive at: fx-team-9e162af63f4c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.336534 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-26 09:43:54.916703) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 09:43:54.917058) ========= echo 9e162af63f4c9772c7a63cfd8e1d96000109aaad in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'9e162af63f4c9772c7a63cfd8e1d96000109aaad'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XdoLjpefIM/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.WxwYKcOJmy/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 9e162af63f4c9772c7a63cfd8e1d96000109aaad program finished with exit code 0 elapsedTime=0.005459 script_repo_revision: '9e162af63f4c9772c7a63cfd8e1d96000109aaad' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 09:43:54.966864) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 09:43:54.967189) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 09:43:54.980237) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-02-26 09:43:54.980617) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.XdoLjpefIM/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.WxwYKcOJmy/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 09:43:55 INFO - MultiFileLogger online at 20160226 09:43:55 in /builds/slave/test 09:43:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:43:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:43:55 INFO - {'append_to_log': False, 09:43:55 INFO - 'base_work_dir': '/builds/slave/test', 09:43:55 INFO - 'blob_upload_branch': 'Fx-Team', 09:43:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:43:55 INFO - 'branch': 'Fx-Team', 09:43:55 INFO - 'buildbot_json_path': 'buildprops.json', 09:43:55 INFO - 'config_files': ('talos/mac_config.py',), 09:43:55 INFO - 'default_actions': ('clobber', 09:43:55 INFO - 'read-buildbot-config', 09:43:55 INFO - 'download-and-extract', 09:43:55 INFO - 'populate-webroot', 09:43:55 INFO - 'create-virtualenv', 09:43:55 INFO - 'install', 09:43:55 INFO - 'run-tests'), 09:43:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:43:55 INFO - 'download_minidump_stackwalk': True, 09:43:55 INFO - 'download_symbols': 'ondemand', 09:43:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:43:55 INFO - 'tooltool.py': '/tools/tooltool.py', 09:43:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:43:55 INFO - '/tools/misc-python/virtualenv.py')}, 09:43:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:43:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:43:55 INFO - 'installer_path': 'installer.exe', 09:43:55 INFO - 'log_level': 'info', 09:43:55 INFO - 'log_name': 'talos', 09:43:55 INFO - 'log_to_console': True, 09:43:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:43:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:43:55 INFO - 'opt_config_files': (), 09:43:55 INFO - 'pip_index': False, 09:43:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:43:55 INFO - 'cmd': ('bash', 09:43:55 INFO - '-c', 09:43:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:43:55 INFO - 'enabled': True, 09:43:55 INFO - 'halt_on_failure': False, 09:43:55 INFO - 'name': 'check_screen_resolution'},), 09:43:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:43:55 INFO - 'cmd': ('bash', 09:43:55 INFO - '-c', 09:43:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:43:55 INFO - 'enabled': True, 09:43:55 INFO - 'halt_on_failure': False, 09:43:55 INFO - 'name': 'check_screen_resolution'},), 09:43:55 INFO - 'run_cmd_checks_enabled': True, 09:43:55 INFO - 'sps_profile': False, 09:43:55 INFO - 'sps_profile_interval': 0, 09:43:55 INFO - 'suite': 'dromaeojs-e10s', 09:43:55 INFO - 'system_bits': '32', 09:43:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:43:55 INFO - 'title': 't-yosemite-r7-0165', 09:43:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:43:55 INFO - 'use_talos_json': True, 09:43:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:43:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:43:55 INFO - 'work_dir': 'build'} 09:43:55 INFO - ##### 09:43:55 INFO - ##### Running clobber step. 09:43:55 INFO - ##### 09:43:55 INFO - Running pre-action listener: _resource_record_pre_action 09:43:55 INFO - Running main action method: clobber 09:43:55 INFO - rmtree: /builds/slave/test/build 09:43:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:43:56 INFO - Running post-action listener: _resource_record_post_action 09:43:56 INFO - ##### 09:43:56 INFO - ##### Running read-buildbot-config step. 09:43:56 INFO - ##### 09:43:56 INFO - Running pre-action listener: _resource_record_pre_action 09:43:56 INFO - Running main action method: read_buildbot_config 09:43:56 INFO - Using buildbot properties: 09:43:56 INFO - { 09:43:56 INFO - "project": "", 09:43:56 INFO - "product": "firefox", 09:43:56 INFO - "script_repo_revision": "production", 09:43:56 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 09:43:56 INFO - "repository": "", 09:43:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 09:43:56 INFO - "buildid": "20160226075831", 09:43:56 INFO - "pgo_build": "False", 09:43:56 INFO - "basedir": "/builds/slave/test", 09:43:56 INFO - "buildnumber": 531, 09:43:56 INFO - "slavename": "t-yosemite-r7-0165", 09:43:56 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:43:56 INFO - "platform": "yosemite_r7", 09:43:56 INFO - "scheduler": "tests-fx-team-macosx64-talos", 09:43:56 INFO - "branch": "fx-team", 09:43:56 INFO - "repo_path": "integration/fx-team", 09:43:56 INFO - "revision": "9e162af63f4c9772c7a63cfd8e1d96000109aaad", 09:43:56 INFO - "stage_platform": "macosx64", 09:43:56 INFO - "builduid": "250d750ff3424a2ab12fb2216e496599", 09:43:56 INFO - "slavebuilddir": "test" 09:43:56 INFO - } 09:43:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 09:43:56 INFO - Running post-action listener: _resource_record_post_action 09:43:56 INFO - ##### 09:43:56 INFO - ##### Running download-and-extract step. 09:43:56 INFO - ##### 09:43:56 INFO - Running pre-action listener: _resource_record_pre_action 09:43:56 INFO - Running main action method: download_and_extract 09:43:56 INFO - mkdir: /builds/slave/test/build/tests 09:43: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')]} 09:43:56 INFO - https://queue.taskcluster.net/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:43:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/test_packages.json 09:43:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/test_packages.json 09:43:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:43:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:43:59 INFO - Downloaded 1277 bytes. 09:43:59 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:43:59 INFO - Using the following test package requirements: 09:43:59 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:43:59 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:43:59 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 09:43:59 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:43:59 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 09:43:59 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:43:59 INFO - u'jsshell-mac.zip'], 09:43:59 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:43:59 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 09:43:59 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:43:59 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:43:59 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 09:43:59 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:43:59 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 09:43:59 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:43:59 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 09:43:59 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:43:59 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:43:59 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 09:43:59 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:59 INFO - https://queue.taskcluster.net/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:43:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:43:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:43:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:43:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:44:00 INFO - Downloaded 17830439 bytes. 09:44:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:44:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:44:03 INFO - Return code: 0 09:44:03 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:44:03 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')]} 09:44:03 INFO - https://queue.taskcluster.net/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:44:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:44:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:44:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:44:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:44:04 INFO - Downloaded 17830439 bytes. 09:44:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:44:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:44:08 INFO - Return code: 0 09:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:08 INFO - https://queue.taskcluster.net/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:44:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 09:44:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 09:44:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 09:44:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:44:09 INFO - Downloaded 10713410 bytes. 09:44:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:44:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:44:10 INFO - Return code: 0 09:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:10 INFO - https://queue.taskcluster.net/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:44:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:44:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:44:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 09:44:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 09:44:15 INFO - Downloaded 111468959 bytes. 09:44:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:44:15 INFO - mkdir: /builds/slave/test/properties 09:44:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:44:15 INFO - Writing to file /builds/slave/test/properties/build_url 09:44:15 INFO - Contents: 09:44:15 INFO - build_url:https://queue.taskcluster.net/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:44:16 INFO - Running post-action listener: _resource_record_post_action 09:44:16 INFO - Running post-action listener: set_extra_try_arguments 09:44:16 INFO - ##### 09:44:16 INFO - ##### Running populate-webroot step. 09:44:16 INFO - ##### 09:44:16 INFO - Running pre-action listener: _resource_record_pre_action 09:44:16 INFO - Running main action method: populate_webroot 09:44:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:44:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:44:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:44:16 INFO - '--tppagecycles', 09:44:16 INFO - '7'], 09:44:16 INFO - 'tests': ['tsvgm']}}, 09:44:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:44:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:44:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:44:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:44:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:44:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:44:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:44:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:16 INFO - 'talos_options': ['--e10s'], 09:44:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:44:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:16 INFO - 'tests': ['damp', 'tps']}, 09:44:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:16 INFO - 'talos_options': ['--e10s'], 09:44:16 INFO - 'tests': ['damp', 'tps']}, 09:44:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:44:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:44:16 INFO - 'other': {'tests': ['a11yr', 09:44:16 INFO - 'ts_paint', 09:44:16 INFO - 'tpaint', 09:44:16 INFO - 'sessionrestore', 09:44:16 INFO - 'sessionrestore_no_auto_restore']}, 09:44:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:44:16 INFO - 'tests': ['a11yr', 09:44:16 INFO - 'ts_paint', 09:44:16 INFO - 'tpaint', 09:44:16 INFO - 'sessionrestore', 09:44:16 INFO - 'sessionrestore_no_auto_restore']}, 09:44:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:44:16 INFO - 'tests': ['a11yr', 09:44:16 INFO - 'ts_paint', 09:44:16 INFO - 'tpaint', 09:44:16 INFO - 'sessionrestore', 09:44:16 INFO - 'sessionrestore_no_auto_restore']}, 09:44:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:44:16 INFO - 'tests': ['a11yr', 09:44:16 INFO - 'ts_paint', 09:44:16 INFO - 'tpaint', 09:44:16 INFO - 'sessionrestore', 09:44:16 INFO - 'sessionrestore_no_auto_restore']}, 09:44:16 INFO - 'other_l64': {'tests': ['a11yr', 09:44:16 INFO - 'ts_paint', 09:44:16 INFO - 'tpaint', 09:44:16 INFO - 'sessionrestore', 09:44:16 INFO - 'sessionrestore_no_auto_restore']}, 09:44:16 INFO - 'other_nol64': {'tests': ['a11yr', 09:44:16 INFO - 'ts_paint', 09:44:16 INFO - 'tpaint', 09:44:16 INFO - 'sessionrestore', 09:44:16 INFO - 'sessionrestore_no_auto_restore']}, 09:44:16 INFO - 'svgr': {'tests': ['tsvgx', 09:44:16 INFO - 'tsvgr_opacity', 09:44:16 INFO - 'tart', 09:44:16 INFO - 'tscrollx', 09:44:16 INFO - 'cart']}, 09:44:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:44:16 INFO - 'tests': ['tsvgx', 09:44:16 INFO - 'tsvgr_opacity', 09:44:16 INFO - 'tart', 09:44:16 INFO - 'tscrollx', 09:44:16 INFO - 'cart']}, 09:44:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:16 INFO - 'tests': ['tp5o']}, 09:44:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:16 INFO - 'talos_options': ['--e10s'], 09:44:16 INFO - 'tests': ['tp5o']}, 09:44:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:16 INFO - 'talos_options': ['--xperf_path', 09:44:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:44:16 INFO - 'tests': ['tp5n']}, 09:44:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:16 INFO - 'talos_options': ['--e10s', 09:44:16 INFO - '--xperf_path', 09:44:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:44:16 INFO - 'tests': ['tp5n']}}, 09:44:16 INFO - 'talos.zip': {'path': '', 09:44:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:44:16 INFO - Running post-action listener: _resource_record_post_action 09:44:16 INFO - ##### 09:44:16 INFO - ##### Running create-virtualenv step. 09:44:16 INFO - ##### 09:44:16 INFO - Running pre-action listener: _resource_record_pre_action 09:44:16 INFO - Running main action method: create_virtualenv 09:44:16 INFO - Creating virtualenv /builds/slave/test/build/venv 09:44:16 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 09:44:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:44:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:44:16 INFO - Using real prefix '/tools/python27' 09:44:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:44:17 INFO - Installing distribute.............................................................................................................................................................................................done. 09:44:19 INFO - Installing pip.................done. 09:44:19 INFO - Return code: 0 09:44:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:19 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 0x109380a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093874c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddf14b92e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109224d30>, '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 0x109048db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10921bb20>, '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.XdoLjpefIM/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.WxwYKcOJmy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 09:44:19 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 09:44:19 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 09:44:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XdoLjpefIM/Render', 09:44:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:19 INFO - 'HOME': '/Users/cltbld', 09:44:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:19 INFO - 'LOGNAME': 'cltbld', 09:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:19 INFO - 'MOZ_NO_REMOTE': '1', 09:44:19 INFO - 'NO_EM_RESTART': '1', 09:44:19 INFO - 'PAGER': '/bin/cat', 09:44:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:19 INFO - 'PWD': '/builds/slave/test', 09:44:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:19 INFO - 'SHELL': '/bin/bash', 09:44:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WxwYKcOJmy/Listeners', 09:44:19 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 09:44:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:19 INFO - 'USER': 'cltbld', 09:44:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:19 INFO - 'XPC_FLAGS': '0x0', 09:44:19 INFO - 'XPC_SERVICE_NAME': '0', 09:44:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:20 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 09:44:20 INFO - Cleaning up... 09:44:20 INFO - Return code: 0 09:44:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:44: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')]} 09:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44: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')]} 09:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109380a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093874c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddf14b92e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109224d30>, '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 0x109048db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10921bb20>, '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.XdoLjpefIM/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.WxwYKcOJmy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 09:44:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:44:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XdoLjpefIM/Render', 09:44:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:20 INFO - 'HOME': '/Users/cltbld', 09:44:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:20 INFO - 'LOGNAME': 'cltbld', 09:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:20 INFO - 'MOZ_NO_REMOTE': '1', 09:44:20 INFO - 'NO_EM_RESTART': '1', 09:44:20 INFO - 'PAGER': '/bin/cat', 09:44:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:20 INFO - 'PWD': '/builds/slave/test', 09:44:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:20 INFO - 'SHELL': '/bin/bash', 09:44:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WxwYKcOJmy/Listeners', 09:44:20 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 09:44:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:20 INFO - 'USER': 'cltbld', 09:44:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:20 INFO - 'XPC_FLAGS': '0x0', 09:44:20 INFO - 'XPC_SERVICE_NAME': '0', 09:44:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:20 INFO - Downloading/unpacking psutil>=0.7.1 09:44:20 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 09:44:20 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 09:44:20 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 09:44:20 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 09:44:20 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 09:44:20 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 09:44:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:44:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:44:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:44:23 INFO - Installing collected packages: psutil 09:44:23 INFO - Running setup.py install for psutil 09:44:23 INFO - building 'psutil._psutil_osx' extension 09:44:23 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 09:44:24 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 09:44:24 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 09:44:24 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 09:44:24 INFO - building 'psutil._psutil_posix' extension 09:44:24 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 09:44:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:44:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:44:24 INFO - ^ 09:44:24 INFO - 1 warning generated. 09:44:24 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 09:44:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:44:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:44:24 INFO - Successfully installed psutil 09:44:24 INFO - Cleaning up... 09:44:24 INFO - Return code: 0 09:44:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:44: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')]} 09:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44: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')]} 09:44:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44: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', '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 0x109380a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093874c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddf14b92e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109224d30>, '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 0x109048db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10921bb20>, '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.XdoLjpefIM/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.WxwYKcOJmy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 09:44: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:44: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 mozsystemmonitor==0.0.0 09:44:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XdoLjpefIM/Render', 09:44:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:24 INFO - 'HOME': '/Users/cltbld', 09:44:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:24 INFO - 'LOGNAME': 'cltbld', 09:44:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:24 INFO - 'MOZ_NO_REMOTE': '1', 09:44:24 INFO - 'NO_EM_RESTART': '1', 09:44:24 INFO - 'PAGER': '/bin/cat', 09:44:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:24 INFO - 'PWD': '/builds/slave/test', 09:44:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:24 INFO - 'SHELL': '/bin/bash', 09:44:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WxwYKcOJmy/Listeners', 09:44:24 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 09:44:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:24 INFO - 'USER': 'cltbld', 09:44:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:24 INFO - 'XPC_FLAGS': '0x0', 09:44:24 INFO - 'XPC_SERVICE_NAME': '0', 09:44:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:44:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:44:25 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 09:44:25 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 09:44:25 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 09:44:25 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 09:44:25 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 09:44:25 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 09:44:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:44:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:44:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:44:27 INFO - Installing collected packages: mozsystemmonitor 09:44:27 INFO - Running setup.py install for mozsystemmonitor 09:44:28 INFO - Successfully installed mozsystemmonitor 09:44:28 INFO - Cleaning up... 09:44:28 INFO - Return code: 0 09:44:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:28 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 0x109380a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093874c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddf14b92e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109224d30>, '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 0x109048db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10921bb20>, '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.XdoLjpefIM/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.WxwYKcOJmy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 09:44:28 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 09:44:28 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 09:44:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XdoLjpefIM/Render', 09:44:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:28 INFO - 'HOME': '/Users/cltbld', 09:44:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:28 INFO - 'LOGNAME': 'cltbld', 09:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:28 INFO - 'MOZ_NO_REMOTE': '1', 09:44:28 INFO - 'NO_EM_RESTART': '1', 09:44:28 INFO - 'PAGER': '/bin/cat', 09:44:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:28 INFO - 'PWD': '/builds/slave/test', 09:44:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:28 INFO - 'SHELL': '/bin/bash', 09:44:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WxwYKcOJmy/Listeners', 09:44:28 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 09:44:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:28 INFO - 'USER': 'cltbld', 09:44:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:28 INFO - 'XPC_FLAGS': '0x0', 09:44:28 INFO - 'XPC_SERVICE_NAME': '0', 09:44:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:44:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:28 INFO - Downloading/unpacking blobuploader==1.2.4 09:44:28 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 09:44:28 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 09:44:28 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 09:44:28 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 09:44:28 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 09:44:28 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 09:44:30 INFO - Downloading blobuploader-1.2.4.tar.gz 09:44:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:44:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:44: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 09:44: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 09:44: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 09:44: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 09:44: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 09:44: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 09:44:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:44:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:44:31 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 09:44:31 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 09:44:31 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 09:44:31 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 09:44:31 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 09:44:31 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 09:44:31 INFO - Downloading docopt-0.6.1.tar.gz 09:44:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:44:32 INFO - Installing collected packages: blobuploader, requests, docopt 09:44:32 INFO - Running setup.py install for blobuploader 09:44:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:44:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:44:32 INFO - Running setup.py install for requests 09:44:32 INFO - Running setup.py install for docopt 09:44:32 INFO - Successfully installed blobuploader requests docopt 09:44:32 INFO - Cleaning up... 09:44:32 INFO - Return code: 0 09:44:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109380a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093874c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddf14b92e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109224d30>, '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 0x109048db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10921bb20>, '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.XdoLjpefIM/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.WxwYKcOJmy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 09:44:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:44:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XdoLjpefIM/Render', 09:44:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:32 INFO - 'HOME': '/Users/cltbld', 09:44:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:32 INFO - 'LOGNAME': 'cltbld', 09:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:32 INFO - 'MOZ_NO_REMOTE': '1', 09:44:32 INFO - 'NO_EM_RESTART': '1', 09:44:32 INFO - 'PAGER': '/bin/cat', 09:44:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:32 INFO - 'PWD': '/builds/slave/test', 09:44:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:32 INFO - 'SHELL': '/bin/bash', 09:44:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WxwYKcOJmy/Listeners', 09:44:32 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 09:44:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:32 INFO - 'USER': 'cltbld', 09:44:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:32 INFO - 'XPC_FLAGS': '0x0', 09:44:32 INFO - 'XPC_SERVICE_NAME': '0', 09:44:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:44:33 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-ocTp7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:44:33 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-dK3k8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:44:33 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-7mmpwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:44:33 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-FAJYQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:44:33 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-DtyaSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:44:33 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-ckbHGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:44:33 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-1MuFcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:44:33 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-kQXl8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:44:34 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-3tPAeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:44:34 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-24NCFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:44:34 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-ED47tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:44:34 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-tThWjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:44:34 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-z01MEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:44:34 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-YHjmkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:34 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-RxiqTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:44:34 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-ivvakf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:44:34 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-rKWF95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:44:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:44:34 INFO - Running setup.py install for manifestparser 09:44:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:44:35 INFO - Running setup.py install for mozcrash 09:44:35 INFO - Running setup.py install for mozdebug 09:44:35 INFO - Running setup.py install for mozdevice 09:44:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:44:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:44:35 INFO - Running setup.py install for mozfile 09:44:35 INFO - Running setup.py install for mozhttpd 09:44:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:44:35 INFO - Running setup.py install for mozinfo 09:44:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:44:36 INFO - Running setup.py install for mozInstall 09:44:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:44:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:44:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:44:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:44:36 INFO - Running setup.py install for mozleak 09:44:36 INFO - Running setup.py install for mozlog 09:44:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:44:36 INFO - Running setup.py install for moznetwork 09:44:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:44:36 INFO - Running setup.py install for mozprocess 09:44:36 INFO - Running setup.py install for mozprofile 09:44:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:44:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:44:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:44:36 INFO - Running setup.py install for mozrunner 09:44:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:44:37 INFO - Running setup.py install for mozscreenshot 09:44:37 INFO - Running setup.py install for moztest 09:44:37 INFO - Running setup.py install for mozversion 09:44:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:44:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:44:37 INFO - Cleaning up... 09:44:37 INFO - Return code: 0 09:44:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:44: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')]} 09:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44: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')]} 09:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109380a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093874c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddf14b92e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109224d30>, '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 0x109048db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10921bb20>, '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.XdoLjpefIM/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.WxwYKcOJmy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 09:44:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:44:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XdoLjpefIM/Render', 09:44:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:37 INFO - 'HOME': '/Users/cltbld', 09:44:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:37 INFO - 'LOGNAME': 'cltbld', 09:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:37 INFO - 'MOZ_NO_REMOTE': '1', 09:44:37 INFO - 'NO_EM_RESTART': '1', 09:44:37 INFO - 'PAGER': '/bin/cat', 09:44:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:37 INFO - 'PWD': '/builds/slave/test', 09:44:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:37 INFO - 'SHELL': '/bin/bash', 09:44:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WxwYKcOJmy/Listeners', 09:44:37 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 09:44:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:37 INFO - 'USER': 'cltbld', 09:44:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:37 INFO - 'XPC_FLAGS': '0x0', 09:44:37 INFO - 'XPC_SERVICE_NAME': '0', 09:44:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:44:37 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-XYT7qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:44:37 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-ISD4bk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:44:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 09:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:44:38 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-qesLK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:44:38 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)) 09:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:44:38 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-Yo90pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:44:38 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)) 09:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:44:38 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-H24RyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:44:38 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)) 09:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:44:38 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-4jcHsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:44:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:44:38 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-0oCVM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:44:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:44:38 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-ux6a4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:44:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:44:38 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-rEs3UX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:44:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:44:38 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-6FyEln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:44:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:44:38 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-rEuZwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:44:39 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)) 09:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:44:39 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-GbpRz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:44:39 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)) 09:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:44:39 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-SGLY4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:44:39 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)) 09:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:44:39 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-Jtxfpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:44:39 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)) 09:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:39 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-figHXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:44:39 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-XL4aAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:44:39 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-QovhoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:44:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:42 INFO - Downloading blessings-1.6.tar.gz 09:44:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:44:42 INFO - Installing collected packages: blessings 09:44:42 INFO - Running setup.py install for blessings 09:44:42 INFO - Successfully installed blessings 09:44:42 INFO - Cleaning up... 09:44:42 INFO - Return code: 0 09:44:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:44:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:44:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:44:42 INFO - Reading from file tmpfile_stdout 09:44:42 INFO - Current package versions: 09:44:42 INFO - blessings == 1.6 09:44:42 INFO - blobuploader == 1.2.4 09:44:42 INFO - docopt == 0.6.1 09:44:42 INFO - manifestparser == 1.1 09:44:42 INFO - mozInstall == 1.12 09:44:42 INFO - mozcrash == 0.16 09:44:42 INFO - mozdebug == 0.1 09:44:42 INFO - mozdevice == 0.48 09:44:42 INFO - mozfile == 1.2 09:44:42 INFO - mozhttpd == 0.7 09:44:42 INFO - mozinfo == 0.9 09:44:42 INFO - mozleak == 0.1 09:44:42 INFO - mozlog == 3.1 09:44:42 INFO - moznetwork == 0.27 09:44:42 INFO - mozprocess == 0.22 09:44:42 INFO - mozprofile == 0.28 09:44:42 INFO - mozrunner == 6.11 09:44:42 INFO - mozscreenshot == 0.1 09:44:42 INFO - mozsystemmonitor == 0.0 09:44:42 INFO - moztest == 0.7 09:44:42 INFO - mozversion == 1.4 09:44:42 INFO - psutil == 3.1.1 09:44:42 INFO - requests == 1.2.3 09:44:42 INFO - wsgiref == 0.1.2 09:44:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:42 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 0x109380a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093874c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddf14b92e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109224d30>, '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 0x109048db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10921bb20>, '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.XdoLjpefIM/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.WxwYKcOJmy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 09:44:42 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 09:44:42 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 09:44:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XdoLjpefIM/Render', 09:44:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:42 INFO - 'HOME': '/Users/cltbld', 09:44:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:42 INFO - 'LOGNAME': 'cltbld', 09:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:42 INFO - 'MOZ_NO_REMOTE': '1', 09:44:42 INFO - 'NO_EM_RESTART': '1', 09:44:42 INFO - 'PAGER': '/bin/cat', 09:44:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:42 INFO - 'PWD': '/builds/slave/test', 09:44:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:42 INFO - 'SHELL': '/bin/bash', 09:44:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WxwYKcOJmy/Listeners', 09:44:42 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 09:44:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:42 INFO - 'USER': 'cltbld', 09:44:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:42 INFO - 'XPC_FLAGS': '0x0', 09:44:42 INFO - 'XPC_SERVICE_NAME': '0', 09:44:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:42 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)) 09:44:42 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)) 09:44:42 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)) 09:44:42 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)) 09:44:42 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)) 09:44:42 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)) 09:44:42 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)) 09:44:42 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)) 09:44:42 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)) 09:44:42 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)) 09:44:42 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)) 09:44:42 INFO - Cleaning up... 09:44:42 INFO - Return code: 0 09:44:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109380a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093874c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddf14b92e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109224d30>, '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 0x109048db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10921bb20>, '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.XdoLjpefIM/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.WxwYKcOJmy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 09:44:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:44:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:44:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XdoLjpefIM/Render', 09:44:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:42 INFO - 'HOME': '/Users/cltbld', 09:44:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:42 INFO - 'LOGNAME': 'cltbld', 09:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:42 INFO - 'MOZ_NO_REMOTE': '1', 09:44:42 INFO - 'NO_EM_RESTART': '1', 09:44:42 INFO - 'PAGER': '/bin/cat', 09:44:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:42 INFO - 'PWD': '/builds/slave/test', 09:44:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:42 INFO - 'SHELL': '/bin/bash', 09:44:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WxwYKcOJmy/Listeners', 09:44:42 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 09:44:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:42 INFO - 'USER': 'cltbld', 09:44:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:42 INFO - 'XPC_FLAGS': '0x0', 09:44:42 INFO - 'XPC_SERVICE_NAME': '0', 09:44:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:44:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:43 INFO - Downloading/unpacking jsonschema 09:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:44:45 INFO - Downloading/unpacking functools32 (from jsonschema) 09:44:45 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 09:44:45 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 09:44:45 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 09:44:45 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 09:44:45 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 09:44:45 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 09:44:45 INFO - Downloading functools32-3.2.3-2.tar.gz 09:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:44:45 INFO - warning: no files found matching '*.txt' 09:44:45 INFO - no previously-included directories found matching 'build' 09:44:45 INFO - no previously-included directories found matching 'dist' 09:44:45 INFO - no previously-included directories found matching '.git*' 09:44:45 INFO - Installing collected packages: jsonschema, functools32 09:44:46 INFO - Running setup.py install for functools32 09:44:46 INFO - warning: no files found matching '*.txt' 09:44:46 INFO - no previously-included directories found matching 'build' 09:44:46 INFO - no previously-included directories found matching 'dist' 09:44:46 INFO - no previously-included directories found matching '.git*' 09:44:46 INFO - Successfully installed jsonschema functools32 09:44:46 INFO - Cleaning up... 09:44:46 INFO - Return code: 0 09:44:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:46 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 0x109380a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093874c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddf14b92e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109224d30>, '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 0x109048db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10921bb20>, '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.XdoLjpefIM/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.WxwYKcOJmy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 09:44:46 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 09:44:46 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 09:44:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XdoLjpefIM/Render', 09:44:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:46 INFO - 'HOME': '/Users/cltbld', 09:44:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:46 INFO - 'LOGNAME': 'cltbld', 09:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:46 INFO - 'MOZ_NO_REMOTE': '1', 09:44:46 INFO - 'NO_EM_RESTART': '1', 09:44:46 INFO - 'PAGER': '/bin/cat', 09:44:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:46 INFO - 'PWD': '/builds/slave/test', 09:44:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:46 INFO - 'SHELL': '/bin/bash', 09:44:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WxwYKcOJmy/Listeners', 09:44:46 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 09:44:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:46 INFO - 'USER': 'cltbld', 09:44:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:46 INFO - 'XPC_FLAGS': '0x0', 09:44:46 INFO - 'XPC_SERVICE_NAME': '0', 09:44:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:46 INFO - Downloading/unpacking flake8 09:44:46 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 09:44:46 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 09:44:46 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 09:44:46 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 09:44:46 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 09:44:46 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 09:44:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:44:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:44:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:44: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 09:44: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 09:44: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 09:44: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 09:44: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 09:44: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 09:44:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:44: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 09:44: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 09:44: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 09:44: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 09:44: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 09:44: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 09:44:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:44:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:44:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:44:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:44:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:44:50 INFO - no previously-included directories found matching 'docs/_build' 09:44:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:44:50 INFO - Running setup.py install for pep8 09:44:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:44:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:44:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:44:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:44:50 INFO - no previously-included directories found matching 'docs/_build' 09:44:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:44:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:44:50 INFO - Cleaning up... 09:44:50 INFO - Return code: 0 09:44:50 INFO - Running post-action listener: _resource_record_post_action 09:44:50 INFO - Running post-action listener: _start_resource_monitoring 09:44:50 INFO - Starting resource monitoring. 09:44:50 INFO - ##### 09:44:50 INFO - ##### Running install step. 09:44:50 INFO - ##### 09:44:50 INFO - Running pre-action listener: _resource_record_pre_action 09:44:50 INFO - Running main action method: install 09:44:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:44:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:44:50 INFO - Reading from file tmpfile_stdout 09:44:50 INFO - Detecting whether we're running mozinstall >=1.0... 09:44:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:44:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:44:50 INFO - Reading from file tmpfile_stdout 09:44:50 INFO - Output received: 09:44:50 INFO - Usage: mozinstall [options] installer 09:44:50 INFO - Options: 09:44:50 INFO - -h, --help show this help message and exit 09:44:50 INFO - -d DEST, --destination=DEST 09:44:50 INFO - Directory to install application into. [default: 09:44:50 INFO - "/builds/slave/test"] 09:44:50 INFO - --app=APP Application being installed. [default: firefox] 09:44:50 INFO - mkdir: /builds/slave/test/build/application 09:44:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:44:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:45:24 INFO - Reading from file tmpfile_stdout 09:45:24 INFO - Output received: 09:45:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:45:24 INFO - Running post-action listener: _resource_record_post_action 09:45:24 INFO - ##### 09:45:24 INFO - ##### Running run-tests step. 09:45:24 INFO - ##### 09:45:24 INFO - Running pre-action listener: _resource_record_pre_action 09:45:24 INFO - Running main action method: run_tests 09:45:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:45:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:45:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:45:24 INFO - 2016-02-26 09:45:24.989 screenresolution[1649:7535] starting screenresolution argv=screenresolution get 09:45:24 INFO - 2016-02-26 09:45:24.991 screenresolution[1649:7535] Display 0: 1600x1200x32@60 09:45:24 INFO - 2016-02-26 09:45:24.998 screenresolution[1650:7537] starting screenresolution argv=screenresolution list 09:45:25 INFO - Available Modes on Display 0 09:45:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:45:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:45:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:45:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:45:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:45:25 INFO - Intel Iris: 09:45:25 INFO - Chipset Model: Intel Iris 09:45:25 INFO - Type: GPU 09:45:25 INFO - Bus: Built-In 09:45:25 INFO - VRAM (Dynamic, Max): 1536 MB 09:45:25 INFO - Vendor: Intel (0x8086) 09:45:25 INFO - Device ID: 0x0a2e 09:45:25 INFO - Revision ID: 0x0009 09:45:25 INFO - Displays: 09:45:25 INFO - Display: 09:45:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:45:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:45:25 INFO - Display Serial Number: 1600x1200 60 09:45:25 INFO - Main Display: Yes 09:45:25 INFO - Mirror: Off 09:45:25 INFO - Online: Yes 09:45:25 INFO - Rotation: Supported 09:45:25 INFO - Return code: 0 09:45:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:45:25 INFO - Python 2.7.3 09:45:25 INFO - Return code: 0 09:45:25 INFO - grabbing minidump binary from tooltool 09:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:25 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 0x109224d30>, '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 0x109048db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10921bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:45:25 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 09:45:25 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 09:45:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:45:25 INFO - Return code: 0 09:45:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:45:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:45:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:45:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:45:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:45:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:45:26 INFO - Return code: 0 09:45:26 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0165', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:45:26 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0165 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:45:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XdoLjpefIM/Render', 09:45:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:26 INFO - 'HOME': '/Users/cltbld', 09:45:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:26 INFO - 'LOGNAME': 'cltbld', 09:45:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:45:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:26 INFO - 'MOZ_NO_REMOTE': '1', 09:45:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:45:26 INFO - 'NO_EM_RESTART': '1', 09:45:26 INFO - 'PAGER': '/bin/cat', 09:45:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:26 INFO - 'PWD': '/builds/slave/test', 09:45:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:45:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:26 INFO - 'SHELL': '/bin/bash', 09:45:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WxwYKcOJmy/Listeners', 09:45:26 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 09:45:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:26 INFO - 'USER': 'cltbld', 09:45:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:26 INFO - 'XPC_FLAGS': '0x0', 09:45:26 INFO - 'XPC_SERVICE_NAME': '0', 09:45:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0165', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:45:26 INFO - mozversion application_buildid: 20160226075831 09:45:26 INFO - mozversion application_changeset: 9e162af63f4c9772c7a63cfd8e1d96000109aaad 09:45:26 INFO - mozversion application_display_name: Nightly 09:45:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:45:26 INFO - mozversion application_name: Firefox 09:45:26 INFO - mozversion application_remotingname: firefox 09:45:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:45:26 INFO - mozversion application_vendor: Mozilla 09:45:26 INFO - mozversion application_version: 47.0a1 09:45:26 INFO - mozversion platform_buildid: 20160226075831 09:45:26 INFO - mozversion platform_changeset: 9e162af63f4c9772c7a63cfd8e1d96000109aaad 09:45:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:45:26 INFO - mozversion platform_version: 47.0a1 09:45:26 INFO - using testdate: 1456508726 09:45:26 INFO - actual date: 1456508726 09:45:26 INFO - starting webserver on 'localhost:49278' 09:45:26 INFO - SUITE-START | Running 2 tests 09:45:26 INFO - TEST-START | dromaeo_css 09:45:26 INFO - operating with platform_type : mac_ 09:45:26 INFO - Initialising browser for dromaeo_css test... 09:45:26 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpgXZYv5/profile http://localhost:49278/getInfo.html) 09:45:29 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 09:45:29 INFO - PROCESS | 1668 | colorDepth:24 09:45:29 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 09:45:29 INFO - PROCESS | 1668 | __metrics 09:45:29 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:45:30 INFO - TEST-INFO | 1668: exit 0 09:45:30 INFO - Browser initialized. 09:45:30 INFO - Running cycle 1/1 for dromaeo_css test... 09:45:30 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpgXZYv5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:45:42 INFO - PROCESS | 1672 | RSS: Main: 256958464 09:45:42 INFO - PROCESS | 1672 | 09:46:32 INFO - PROCESS | 1672 | 1456508792519 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] 09:48:42 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 09:48:44 INFO - PROCESS | 1672 | RSS: Main: 269848576 09:48:44 INFO - PROCESS | 1672 | 09:51:46 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 09:51:46 INFO - PROCESS | 1672 | RSS: Main: 281640960 09:51:46 INFO - PROCESS | 1672 | 09:54:48 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 09:54:48 INFO - PROCESS | 1672 | RSS: Main: 282673152 09:54:48 INFO - PROCESS | 1672 | 09:57:50 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 09:57:51 INFO - PROCESS | 1672 | RSS: Main: 285147136 09:57:51 INFO - PROCESS | 1672 | 10:00:53 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 10:00:54 INFO - PROCESS | 1672 | RSS: Main: 287174656 10:00:54 INFO - PROCESS | 1672 | 10:03:57 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 10:03:57 INFO - PROCESS | 1672 | RSS: Main: 288698368 10:03:57 INFO - PROCESS | 1672 | 10:03:57 INFO - PROCESS | 1672 | __start_tp_report 10:03:57 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 10:03:57 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 10:03:57 INFO - PROCESS | 1672 | |i|pagename|runs| 10:03:57 INFO - PROCESS | 1672 | |0;dojo.html;3442.7934323940567;3508.2808024354995;3537.310224506219;3559.1813882806955;3568.7858728476294;5098.694078355301;5695.145728140781;5704.172894930238;5709.828705138847;5741.282339707536;5577.944220557793;5640.153976903466;5704.914426283599;5729.484346408823;5729.914051289234;4917.311576379309;5104.412992505853;5165.457626949173;5196.220566914974;5257.395399529046;5159.948400515985;5305.973470132644;5313.282706834567;5318.228856815759;5324.307839980797;5123.743812809382;5124.692518448867;5180.352455943007;5193.9740301298625;5261.316028916254;5166.715830629314;5167.302414174076;5190.403103643054;5199.766010529535;5208.427073021964;5119.360079990001;5134.537891589737;5162.819301324435;5181.378234611833;5225.686458812484;4720.693154944917;5569.415211402826;5574.470425309589;5639.548836093103;5675.858103547403;6128.172696685935;6130.325664176981;6141.477974372184;6149.016157414792;6180.165677633507;6182.103594978747;6186.536009799238;6186.876262474771;6213.875722485525;6218;5658.490735833795;5702.942970570324;5800.303963524404;5804.970975145097;5845.210896528999;6243.605420108321;6264.561480696399;6270.561060725797;6275.529335299871;6288.5283603728985;5984.401559844068;6128.380904898417;6133.891171610156;6139.9828168395225;6144.9553575892205;6142.355052719489;6143.818944274807;6212.161358216673;6220.471259942865;6247.125402443661;6052.334243233241;6074.878502429927;6094.644720354235;6112.685862051835;6184.752609895554;6154.076888466766;6173.382661733791;6205.348438413902;6207.193064901534;6224.097505861625;4808.8797780055775;4888.5111488850835;4899.461059283547;4908.190148625436;4940.061388336277;3236.838158092086;3962.5443074046852;4340.544242854455;4347.347897815353;4377.78111094444;4829.299751536078;5699.914501282484;5777.653340799481;5800.738966746507;5820.738066787005;6151.138840562325;6164.8767024659255;6169.784057557964;6189.257289125334;6195.256569211723;4812.759362031885;5804.82585522435;5836.095405212199;5855.765769369263;5866.73599688015;5267.525922666901;5334.626576139711;5357.276767636397;5365.302510673588;5377.838664840061;6328.936710632835;6399.9040014399825;6412.839679007969;6413.486921046305;6442.2591401989375;6202.472789812917;6206.844828879314;6215.005599104122;6219.129321894848;6224.470919971853;6144.494598823317;6264.5614806964895;6341.112244285711;6373.6175829450385;6428.903566446601;6092.886012546767;6101.005087479836;6101.297630694255;6102.481289090477;6134.957077261001;4849.878753031061;6142.740738148758;6155;6163.3836616338;6174.197354343906;5998.310194327708;6040.426159514839;6098.522998456991;6109;6112.633242005494;4513.029698614813;5154.433012368711;5995.160677505066;6049.848753781191;6097.634141951497;5266.262723218829;5381.546982314675;5802;5895.41045895407;5907.143464197753;6029.306629737636;6054.606450580698;6057.57596968208;6094.847628809315;6143.232095988002;5959.374265702212;5967.582269241111;5990.7304171311525;6012.128241405059;6018.488428483628 10:03:57 INFO - PROCESS | 1672 | |1;ext.html;453.5283305362423;472.9217384363651;473.50991723566113;535.6464733276039;553.9806755569751;36011.4598281026;36610.633893661055;36666.81666591667;36715.449268261;36749.632503674955;37378.62621373786;37749.433758493644;37943.430848537224;38299.23401531968;38355.80822095893;9133.954330228356;9341.299402544802;9355.251579873593;9357.204637605812;9423.10480504351;9238.769030774218;9502.619895204218;9524.80950380992;9528.38065525742;9554.665586704466;9466.574004169794;9542.475163865985;9559.426434413923;9571.234301255918;9578.808423831519;9478.052194780536;9526.761830954247;9538.141567258945;9564.66523671668;9594.04059594042;9304.67433639826;9446.38598491096;9452.43285402878;9459.621615135386;9484.19384352331;36404.27191456156;36644.26711465756;36700;36929.26141477156;37105.44341834875;3105.332353543999;3155.8737650493954;3189.3940151371166;3335.0828522156357;3535.398982173011;27518;27822.582661260098;27835.02577409781;28240.576391354145;28442.71557284442;2585.5391703687546;2616.6205900144373;2736.0834120569634;2741.821781584191;2753.7796976241852;393717;394271;397393.0260697385;399584.9999999971;399661;51017.97964040773;59912.10131848026;61189;61280.69359653173;61305.38694613086;66848;67580.66209668921;68164.6591767048;69019.65490172517;69237.65381173062;15945.282462288993;16048.518544443685;16091.195440227943;16146.838531614534;16168.43410480651;12226.816597751042;12348.629541113782;12377.504899803907;12412.62762117138;12489.875101249054;19740;20049.59900801976;20149.19403223884;20154.193832246838;20165.596688066158;8650.567471626393;8900.910990890137;8909.331800115016;8931.642734290555;8948.239399650973;942.5193151492651;956.4404823178379;982.2976571751232;1056.0970370333255;1063.8670166229222;27985.72014279872;28720.856395718307;28952.27619309492;29217.41565168727;29297.267568310537;1057.7990181865575;1061.5117046158853;1078.7734575739025;1096.6216655253925;1100.273819279272;13288.534901278408;13992;14864.925675371554;14908.235294117647;15084.396624134912;514066.8593314094;519307;521295;525618;528751;55864.441355586736;56047;56402.153967690516;56620.71689641525;56969.43030569641;1342.7515909556764;1374.5738820965532;1380.1374141161773;1399.664080620664;1406.7749160134329;24139;24148.63777043381;27582.724172758015;30260;30598.694013059583;50965.745171273906;51010.489895100574;51418.971620568125;51494.742526287126;51735;487588;492249;506058;506400;507659;38493.80753096216;39856.800715996236;41838.79080604578;42598.361024585276;43028.56971430246;44019;44355.77822110869;45269;45429.77285113553;45594.54405455903;36940.63059369372;37428.81285593555;37542.624573755005;37697.05757356088;37705;36550.45174322334;36729.26541469209;36833.63166368409;36930;37337.81331093327;36240.81879590585;36565;36858;37252.62747372492;37409;27640.723592763814;27702.307442314104;27912.86043569769;28682.42635147327;28858.42283154367;22689.092436302362;24887.87556062208;25113.372165695273;25334.746652533977;25451.74548254494 10:03:57 INFO - PROCESS | 1672 | |2;jquery.html;347.23954539558383;349.36241359518874;354.6612984599707;361.98733044343453;362.07309288222154;16081.839181608195;18310.809797363163;18691.813081869193;20161.99190040496;20289.898550507263;19162.329318473858;19645.017749112558;20246.29137980171;20332.59334813303;20347;5709.143628455723;6012.9398706013035;6030.788922387717;6035.849103772419;6039.516838652898;4199.4120823084795;5878.50032747217;6229.563930524865;6506.121673574078;6532.0201969704685;6453.354664533533;6456.2575303840185;6464.353564643545;6479.157709497782;6495.967520162416;5514.862128446801;5781.161731548902;5783.768649254025;5804.651720896739;5809.622374545641;5450.796401996237;5452.972735136299;5547.25112109864;5589.273394458735;5599.300087489064;10661.200409969284;10974.725631859188;13318.267495287755;13376.063675542717;13513.86486135136;1841.5488205389631;1933.1397528100001;2167.360628614547;2232.386093824195;2436.7075950886006;9260.953695231481;9575.952120239424;9695.757606059835;9705.417674939526;9818.165455936254;1664.941727039548;1693.0857337037985;1735.8524525415355;1738.3307426640833;1790.8030116687285;99034.50482747612;101304;103187.48406257921;105916.47041764742;108966;10687.78624427507;10977.451127443595;11233.943830280796;11239.887601124048;11333.886661133449;13326.93336533311;13339.132956357806;13358.599242022754;13367.264800435874;13458.192508449329;7183.568985860865;7511.985881905982;8333.708320208885;8403.327733781283;8492.193241642035;8320.417570770109;8506.276966457921;8589;8612.18184272493;8621.568921553897;4417.933730994037;4460.107978404268;4460.799264033127;4471.396361491157;4492.146492166478;1464.7729601911722;1696.380821000326;1810.2035104554218;1865.2445759467166;1900.4963684623585;871.4640496094983;934.3926447808842;950.6910254167424;994.9801453510065;1009.9141572966233;13885.652858678412;15482.845171548366;16571.585710357336;20062.699059514118;20063.29778457747;884.8539990901558;906;932.8973812880578;963.8843338799389;987.5802783816849;10174.389536627827;10599.364038157735;10604.416757078434;10630.468476576294;10765.569377224823;639592;646666.7666661637;653623;658652;665404;92314;100921;123906;127310;129841;1026.14829691356;1029.5933106422922;1039.262123892045;1041.953112109957;1047.157038583932;17307;17365.913170434065;17389.304427823252;17421.564460888072;17754.91122544379;37328.81335593413;45915.31127033164;46359.768201158775;48991.51008489869;51361;44774;74082.62958685172;75114.62442687752;75565.62217188878;77261.22738772765;7680.347170490348;7841.137474877645;8065.838683226185;8127.674893004214;8184.7953801155445;7618.923810762043;8876.979147398131;11278.887211127783;12719.364031798188;13075.738485230051;11301.26541774782;11338.659840204808;11455.656330310105;11488.483018264365;11930.22453540517;9284.210842078499;11125.388103654377;11133.220674552704;11522.308661480338;11764.529418823151;10985.560577576807;11519.136064795006;11547.480363383836;11689.941550292195;11770.882291176978;8073.959630201812;8150.796230094295;8160.8367832641825;8467.61895714682;8474.110218426977;10758.46207689628;10878.23852330361;11505.137114716263;11508.654740357802;11811.17321787501 10:03:57 INFO - PROCESS | 1672 | |3;mootools.html;1519.9588282026812;1539.5843122356964;1547.736884729596;1871.15797890949;1871.4479228627554;7847.176046515119;8502.872456913152;8589.141085891408;8818.809460722809;8830.77923051924;6480.513961452886;8269.635510140819;8525.658973641046;8571.271441927443;8588.785280367978;2441.9389515262174;2453.055573604162;2464.667269918565;2473.628955656648;2474.6288056791445;2416.66166736657;2481.838680485772;2484.142970675114;2484.2050543825985;2488.4276616378243;2441.6215486599604;2452.5708001099824;2492.5638013347593;2492.950140997188;2494.625806129086;2446.4984678141027;2470.950580988379;2481.131603938616;2483.888225029878;2489.4523204894895;2034.4201902457728;2439.3413778279764;2471.369800700828;2478.5662509060844;2478.5910324796387;7358.852822943565;8761.123887611251;8772.824543509158;8778.29773618109;8784.692535761218;5300.92048619271;5444.183372494118;5445.156000819879;5469.726513674301;5470;3440;3442.087846720621;3499.1427100360575;3691.7600355977042;3693.5752388475403;1050.8686414198226;1061.2571200159919;1061.697416236369;1062.654637242899;1062.7077553672725;11669.70825729355;11709.765804683944;11723.237989530653;11736.061115110771;11753;3928.980355098206;4825.372701548847;4904.337914381585;4942.20924652054;4946.431160416598;10038.899611003942;10049.648262310784;10053.296269261082;10065.647702330383;10111.797764044677;5459.2902922619805;5460.208269800936;5481.479259470344;5538.667679939216;5571.526420254324;4416.867493975186;4830.492798256132;4909.950900491021;4966.329545511309;4971.030649023406;3869.032741814546;3921.4117882317883;3929.4891664084057;3942.6648734857285;3979.5025621797276;1292.2440372382073;1294.1070661243712;1297.7858653322285;1307.1438207973792;1314.90795644304;1084.8643919510062;1105.4251789069638;1122.3995162587976;1348.3864841497095;1365.5357178559339;7980.241877021674;8032.196780321921;8109.553974531457;8136.389770767216;8142.389320800964;508.1767536590747;516.1741214057478;517.2241637543684;517.6635187128321;518.0467938992273;6125.663088530085;6129.233845769279;6163.537734669918;6202.44178023971;6233.96883015582;10197.694069177936;10492.108170805413;10500.579976800842;10595;10681.679549613524;10250.692479225636;10391.636292729718;10425.175594270971;10494.947525262325;10530.210234232463;8209.05595856484;8279.296259817862;8280.99999999988;8322.29260512851;8375.45559538628;7669.769906902802;7680.155182929761;7819.41354398411;7826.960865195638;7828.725994590162;9290.62837486493;9426.95286523563;9491.240700743785;9553.570089345858;9645.662401815904;9724.416535007922;9864.260180486348;9874.802503949737;9887.357321774061;9921.355111917703;6487.870242595216;7020.824479387852;7392.96303518479;7421.888671670037;7461.850762984818;8154.714584989497;8155.9184408157535;8174.182581741778;8179.386546008954;8267.62795674208;7156.391706704989;7202.89195662076;7300.23347548521;7324.08448943882;7372.373348265458;6420.06908998202;6783.86432271342;6863.279355667583;7152.034475345762;7270.600116993616;7521.097468303619;7573.886391704019;7619.123800762984;7629.961850190713;7634.50375725576;6120.265568131853;6909.205441374306;6927.134108236471;6934.445244380337;6987.615681137586;6977.546459480118;6992.61540615271;7035.155781306276;7070.611116388648;7102.9289707104335 10:03:57 INFO - PROCESS | 1672 | |4;prototype.html;281.5171980054207;327.5545258448511;328.3728079368407;329.9433465541171;330.4811446029733;5358.732063396834;6650.501212409071;6929.514933954612;6965.6517174141345;6970.546914450557;6820.454363650909;6839.316068393158;6886.2080860701035;6895.689693963771;6896.344847239517;4046.9680231540915;4728.9290660639945;4850.369451971239;4931.753412329387;5001.14980453322;4941.851744447672;4946.455889852114;4964.05682920244;4966;4971.602271818246;4928.704277743329;4928.901421971558;4935.432425271086;4955.603551715854;5001.8249361272365;4932.506749325057;4940.851774446773;4952.628552858514;4978.278149668277;4987.47631498691;3457.481377793326;4247.638950689196;4251.298535741599;4257.744535327859;4284.207421627009;6206.596571222901;6511.316311787242;6512.413882750528;6542.214934207926;6552.574082684658;4262.722923009995;5717.971410142923;5784.566157538159;5784.681842498703;5803.361630220672;6478.2873883872735;6792.218894827109;7347.228541003225;7347.816304592375;7360.300771426706;4579.969506860963;4596.54034596541;4611.492735799059;4620.330052142421;4637.559431853969;5381.650192737459;6136.9873970795215;6796.592204467748;7773.2226777322385;7843.490173138728;3979.383195604686;4089.9182016359505;4667.556582124693;4714.316424118552;4720.386349774507;3727.6458736419995;4591.9081618367445;4759.50025247351;4772.76136193189;4779.259214821708;5742.827715168552;5743.4543718346695;5753.913691294634;5783.768649254067;5784.21913041734;7412.96293518529;7430.071241094864;7430.145533263636;7450.888236676454;7472.738454154079;1650.4553497345846;1671.6322409069985;1672.3143511160365;1672.4564516532175;1673.238676402234;1025.3386565665253;1063.2716589136467;1067.1356201476829;1070.8500809886623;1083.1010261483107;6884.173899132036;6897.137857767779;6911.9308806912295;6949.89575156373;6990.440764738809;5752.36723960364;6047.637141771508;7650.655720492591;7656.578888161204;7662.080550333884;5609.943900560942;6640.667966601651;6810;6924.6537673116145;6954.374106330454;4045.6763458923215;4078.430588729141;4082.2243773682903;4092.2224777292217;4097.938530922039;8072.394570407126;8079.070906845788;8091.716789912325;8092.514449133071;8115.837683246302;7686.269804368688;7981.161977992343;8010.959945200237;8022.879656805153;8094.797630059178;7522.134954480195;8045;8099.635516401776;8115.513069215866;8137.471064380915;7770.456068075407;7785.92214077852;7792.532448053135;7803.882941755992;7815.570143641927;7573.810654733676;7590.316871481593;7592.582407967615;7636.770896873103;7669.309762121436;6494.772682956074;7693.422993275415;8037.959810200911;8068.59657017135;8094.838103237785;4693.272542755878;4726.503717109654;4738.573528382462;4743.881402964954;4754.7147171169845;5359.839204823861;6092.512598992159;7635.503692259986;7695.6921723130445;7706;6228.719707613259;7336.853262934818;7353.0441042664115;7392.667329970272;7403.037605111301;5965.492933100735;7100.218975912542;7367;7370.484066115535;7376;7182.96408517954;7195.553511806011;7196.136463624399;7206.171290301682;7274.927250727636;5935.792247271324;7400.777976660709;7419.183889772229;7425.628718563942;7429.44279179053;5920.970395147997;6214.627122372672;6866.004429357616;7237.457190710823;7318.780436586911 10:03:57 INFO - PROCESS | 1672 | |5;yui.html;673.2829536543582;730.1019745712773;736.6427282767856;741.3809469093305;768.8539177556268;14532.78200826987;14684.926575367135;14783.113013219214;14805.407783688639;14813.407463701453;13565.796513052312;13616.319184040784;13641.72716545671;13643.522476713317;13678.589642310746;806.7297455352464;840.1388576708891;841.7643059943196;847.5253857839599;848.5248260973843;822.3051521464353;830.5681045856152;833.6332013913889;834.8872902158222;842.2503971465401;851.5401683091154;873.2620935309653;879.8152387998528;880.7357792662208;882.5322579033091;858.8110615664543;863.0290922711949;872.2150064941603;874.4272501511521;874.606427107804;522.3183745212497;625.9029850373199;636.7962252079336;644.9387308205713;646.615263917968;14950.775738363933;15177.392904283815;15181.240937953058;15208.771868421982;15227;11890.58382956601;12307.69230769229;12385.071119666061;12543.435545400478;12569.685757856036;10763.892361076445;10858.294210876267;10911.618093366773;11052.834207486894;11104.000639942444;3391.9491207631904;3395.847186876572;3463.5324231228715;3473.4442489201606;3533.893983180483;70396.94404583935;76756.7081127292;81200;81353;81737.59131204366;9183.081691830763;9302.348835581444;9349.672761453316;9378.296627752945;9601.663941762004;16239.756403653955;19695.310664126686;19949.700754488695;20009.99950002494;20060.498487537636;7352.301531354513;7415.555066696015;7433.293837085468;7459.813504662427;7517.924820751832;3509.420945543957;3527.2592755521114;3534.8939531814085;3549;3580.051286409104;3524.2599054198904;3554.20030493137;3559.1635965548076;3573;3573.3210689968823;663.9900401493982;672.4485921544384;673.5520878615764;675.0245894682137;675.993240067593;498.26505903791616;515.047162748919;541.7453796715538;593.4866340615337;611.9082137679295;6751.763688270887;7379.3358597726465;8168.387370947203;8286.792830179294;8336.291415229773;596.260636810352;599.6971529377637;600.4325912013193;602.4006113916681;603.5805115444812;3784.545854497423;3809.447630093621;3834.482344883461;3995.800209989489;4013.959860401417;63600;77498.96256743406;78956;79499;79844.60077699574;71196.64401677958;73916.15209619803;75067.62466187743;75104;75123;48963.75518122387;67043.66478167675;67145;67226.66386668035;69450.65274673696;8472.661093556435;8512.914870851213;8573.442726222776;8584.442011269248;8630.482171069756;47122.35071772608;47375.52624473711;48095.27857082216;48226.5177348236;49538.75230623968;72865.27134728584;74114.62942685468;74717.62641186759;74889;75140;10633.89366106329;10715.196360272856;10772.299800512941;10895.128389728961;11065.5020524075;11615.012723918562;11867.169298149392;12291.69270768238;12307.30917693936;12563.18339307942;11272.154588405738;11489.942550287195;11567.305961642329;11619.883801161881;11792.174547781917;11195.160362972647;11265.324080555192;11291.3789741565;11467.254628449124;12013.81979270329;10875.184361173102;11597.130215233723;11908.880911190778;11926.344051076927;12017.278963262232;9242.676506322246;9586.472743999147;9708.75728106803;9832.508374581384;9961.452120133463;7794.22057794216;8257.83484330298;9497.952510237405;9760.609575616896;9870.753231169278 10:03:57 INFO - PROCESS | 1672 | __end_tp_report 10:03:57 INFO - PROCESS | 1672 | __start_cc_report 10:03:57 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,348 10:03:57 INFO - PROCESS | 1672 | __end_cc_report 10:03:57 INFO - PROCESS | 1672 | __startTimestamp1456509837277__endTimestamp 10:03:57 INFO - PROCESS | 1672 | 10:03:57 INFO - PROCESS | 1672 | ------- Summary: start ------- 10:03:57 INFO - PROCESS | 1672 | Number of tests: 6 10:03:57 INFO - PROCESS | 1672 | 10:03:57 INFO - PROCESS | 1672 | [#0] dojo.html Cycles:165 Average:5669.43 Median:5907.14 stddev:668.45 (11.3%) stddev-sans-first:647.27 10:03:57 INFO - PROCESS | 1672 | Values: 3442.8 3508.3 3537.3 3559.2 3568.8 5098.7 5695.1 5704.2 5709.8 5741.3 5577.9 5640.2 5704.9 5729.5 5729.9 4917.3 5104.4 5165.5 5196.2 5257.4 5159.9 5306.0 5313.3 5318.2 5324.3 5123.7 5124.7 5180.4 5194.0 5261.3 5166.7 5167.3 5190.4 5199.8 5208.4 5119.4 5134.5 5162.8 5181.4 5225.7 4720.7 5569.4 5574.5 5639.5 5675.9 6128.2 6130.3 6141.5 6149.0 6180.2 6182.1 6186.5 6186.9 6213.9 6218.0 5658.5 5702.9 5800.3 5805.0 5845.2 6243.6 6264.6 6270.6 6275.5 6288.5 5984.4 6128.4 6133.9 6140.0 6145.0 6142.4 6143.8 6212.2 6220.5 6247.1 6052.3 6074.9 6094.6 6112.7 6184.8 6154.1 6173.4 6205.3 6207.2 6224.1 4808.9 4888.5 4899.5 4908.2 4940.1 3236.8 3962.5 4340.5 4347.3 4377.8 4829.3 5699.9 5777.7 5800.7 5820.7 6151.1 6164.9 6169.8 6189.3 6195.3 4812.8 5804.8 5836.1 5855.8 5866.7 5267.5 5334.6 5357.3 5365.3 5377.8 6328.9 6399.9 6412.8 6413.5 6442.3 6202.5 6206.8 6215.0 6219.1 6224.5 6144.5 6264.6 6341.1 6373.6 6428.9 6092.9 6101.0 6101.3 6102.5 6135.0 4849.9 6142.7 6155.0 6163.4 6174.2 5998.3 6040.4 6098.5 6109.0 6112.6 4513.0 5154.4 5995.2 6049.8 6097.6 5266.3 5381.5 5802.0 5895.4 5907.1 6029.3 6054.6 6057.6 6094.8 6143.2 5959.4 5967.6 5990.7 6012.1 6018.5 10:03:57 INFO - PROCESS | 1672 | 10:03:57 INFO - PROCESS | 1672 | [#1] ext.html Cycles:180 Average:61892.07 Median:37619.84 stddev:126544.78 (336.4%) stddev-sans-first:126815.69 10:03:57 INFO - PROCESS | 1672 | Values: 453.5 472.9 473.5 535.6 554.0 36011.5 36610.6 36666.8 36715.4 36749.6 37378.6 37749.4 37943.4 38299.2 38355.8 9134.0 9341.3 9355.3 9357.2 9423.1 9238.8 9502.6 9524.8 9528.4 9554.7 9466.6 9542.5 9559.4 9571.2 9578.8 9478.1 9526.8 9538.1 9564.7 9594.0 9304.7 9446.4 9452.4 9459.6 9484.2 36404.3 36644.3 36700.0 36929.3 37105.4 3105.3 3155.9 3189.4 3335.1 3535.4 27518.0 27822.6 27835.0 28240.6 28442.7 2585.5 2616.6 2736.1 2741.8 2753.8 393717.0 394271.0 397393.0 399585.0 399661.0 51018.0 59912.1 61189.0 61280.7 61305.4 66848.0 67580.7 68164.7 69019.7 69237.7 15945.3 16048.5 16091.2 16146.8 16168.4 12226.8 12348.6 12377.5 12412.6 12489.9 19740.0 20049.6 20149.2 20154.2 20165.6 8650.6 8900.9 8909.3 8931.6 8948.2 942.5 956.4 982.3 1056.1 1063.9 27985.7 28720.9 28952.3 29217.4 29297.3 1057.8 1061.5 1078.8 1096.6 1100.3 13288.5 13992.0 14864.9 14908.2 15084.4 514066.9 519307.0 521295.0 525618.0 528751.0 55864.4 56047.0 56402.2 56620.7 56969.4 1342.8 1374.6 1380.1 1399.7 1406.8 24139.0 24148.6 27582.7 30260.0 30598.7 50965.7 51010.5 51419.0 51494.7 51735.0 487588.0 492249.0 506058.0 506400.0 507659.0 38493.8 39856.8 41838.8 42598.4 43028.6 44019.0 44355.8 45269.0 45429.8 45594.5 36940.6 37428.8 37542.6 37697.1 37705.0 36550.5 36729.3 36833.6 36930.0 37337.8 36240.8 36565.0 36858.0 37252.6 37409.0 27640.7 27702.3 27912.9 28682.4 28858.4 22689.1 24887.9 25113.4 25334.7 25451.7 10:03:57 INFO - PROCESS | 1672 | 10:03:57 INFO - PROCESS | 1672 | [#2] jquery.html Cycles:180 Average:34684.34 Median:1391.97 stddev:107967.71 (7756.4%) stddev-sans-first:108239.80 10:03:57 INFO - PROCESS | 1672 | Values: 347.2 349.4 354.7 362.0 362.1 16081.8 18310.8 18691.8 20162.0 20289.9 19162.3 19645.0 20246.3 20332.6 20347.0 5709.1 6012.9 6030.8 6035.8 6039.5 4199.4 5878.5 6229.6 6506.1 6532.0 6453.4 6456.3 6464.4 6479.2 6496.0 5514.9 5781.2 5783.8 5804.7 5809.6 5450.8 5453.0 5547.3 5589.3 5599.3 10661.2 10974.7 13318.3 13376.1 13513.9 1841.5 1933.1 2167.4 2232.4 2436.7 9261.0 9576.0 9695.8 9705.4 9818.2 1664.9 1693.1 1735.9 1738.3 1790.8 99034.5 101304.0 103187.5 105916.5 108966.0 10687.8 10977.5 11233.9 11239.9 11333.9 13326.9 13339.1 13358.6 13367.3 13458.2 7183.6 7512.0 8333.7 8403.3 8492.2 8320.4 8506.3 8589.0 8612.2 8621.6 4417.9 4460.1 4460.8 4471.4 4492.1 1464.8 1696.4 1810.2 1865.2 1900.5 871.5 934.4 950.7 995.0 1009.9 13885.7 15482.8 16571.6 20062.7 20063.3 884.9 906.0 932.9 963.9 987.6 10174.4 10599.4 10604.4 10630.5 10765.6 639592.0 646666.8 653623.0 658652.0 665404.0 92314.0 100921.0 123906.0 127310.0 129841.0 1026.1 1029.6 1039.3 1042.0 1047.2 17307.0 17365.9 17389.3 17421.6 17754.9 37328.8 45915.3 46359.8 48991.5 51361.0 44774.0 74082.6 75114.6 75565.6 77261.2 7680.3 7841.1 8065.8 8127.7 8184.8 7618.9 8877.0 11278.9 12719.4 13075.7 11301.3 11338.7 11455.7 11488.5 11930.2 9284.2 11125.4 11133.2 11522.3 11764.5 10985.6 11519.1 11547.5 11689.9 11770.9 8074.0 8150.8 8160.8 8467.6 8474.1 10758.5 10878.2 11505.1 11508.7 11811.2 10:03:57 INFO - PROCESS | 1672 | 10:03:57 INFO - PROCESS | 1672 | [#3] mootools.html Cycles:180 Average:5953.01 Median:5372.55 stddev:3149.84 (58.6%) stddev-sans-first:3141.05 10:03:57 INFO - PROCESS | 1672 | Values: 1520.0 1539.6 1547.7 1871.2 1871.4 7847.2 8502.9 8589.1 8818.8 8830.8 6480.5 8269.6 8525.7 8571.3 8588.8 2441.9 2453.1 2464.7 2473.6 2474.6 2416.7 2481.8 2484.1 2484.2 2488.4 2441.6 2452.6 2492.6 2493.0 2494.6 2446.5 2471.0 2481.1 2483.9 2489.5 2034.4 2439.3 2471.4 2478.6 2478.6 7358.9 8761.1 8772.8 8778.3 8784.7 5300.9 5444.2 5445.2 5469.7 5470.0 3440.0 3442.1 3499.1 3691.8 3693.6 1050.9 1061.3 1061.7 1062.7 1062.7 11669.7 11709.8 11723.2 11736.1 11753.0 3929.0 4825.4 4904.3 4942.2 4946.4 10038.9 10049.6 10053.3 10065.6 10111.8 5459.3 5460.2 5481.5 5538.7 5571.5 4416.9 4830.5 4910.0 4966.3 4971.0 3869.0 3921.4 3929.5 3942.7 3979.5 1292.2 1294.1 1297.8 1307.1 1314.9 1084.9 1105.4 1122.4 1348.4 1365.5 7980.2 8032.2 8109.6 8136.4 8142.4 508.2 516.2 517.2 517.7 518.0 6125.7 6129.2 6163.5 6202.4 6234.0 10197.7 10492.1 10500.6 10595.0 10681.7 10250.7 10391.6 10425.2 10494.9 10530.2 8209.1 8279.3 8281.0 8322.3 8375.5 7669.8 7680.2 7819.4 7827.0 7828.7 9290.6 9427.0 9491.2 9553.6 9645.7 9724.4 9864.3 9874.8 9887.4 9921.4 6487.9 7020.8 7393.0 7421.9 7461.9 8154.7 8155.9 8174.2 8179.4 8267.6 7156.4 7202.9 7300.2 7324.1 7372.4 6420.1 6783.9 6863.3 7152.0 7270.6 7521.1 7573.9 7619.1 7630.0 7634.5 6120.3 6909.2 6927.1 6934.4 6987.6 6977.5 6992.6 7035.2 7070.6 7102.9 10:03:57 INFO - PROCESS | 1672 | 10:03:57 INFO - PROCESS | 1672 | [#4] prototype.html Cycles:180 Average:5867.95 Median:6503.04 stddev:1947.95 (30.0%) stddev-sans-first:1907.75 10:03:57 INFO - PROCESS | 1672 | Values: 281.5 327.6 328.4 329.9 330.5 5358.7 6650.5 6929.5 6965.7 6970.5 6820.5 6839.3 6886.2 6895.7 6896.3 4047.0 4728.9 4850.4 4931.8 5001.1 4941.9 4946.5 4964.1 4966.0 4971.6 4928.7 4928.9 4935.4 4955.6 5001.8 4932.5 4940.9 4952.6 4978.3 4987.5 3457.5 4247.6 4251.3 4257.7 4284.2 6206.6 6511.3 6512.4 6542.2 6552.6 4262.7 5718.0 5784.6 5784.7 5803.4 6478.3 6792.2 7347.2 7347.8 7360.3 4580.0 4596.5 4611.5 4620.3 4637.6 5381.7 6137.0 6796.6 7773.2 7843.5 3979.4 4089.9 4667.6 4714.3 4720.4 3727.6 4591.9 4759.5 4772.8 4779.3 5742.8 5743.5 5753.9 5783.8 5784.2 7413.0 7430.1 7430.1 7450.9 7472.7 1650.5 1671.6 1672.3 1672.5 1673.2 1025.3 1063.3 1067.1 1070.9 1083.1 6884.2 6897.1 6911.9 6949.9 6990.4 5752.4 6047.6 7650.7 7656.6 7662.1 5609.9 6640.7 6810.0 6924.7 6954.4 4045.7 4078.4 4082.2 4092.2 4097.9 8072.4 8079.1 8091.7 8092.5 8115.8 7686.3 7981.2 8011.0 8022.9 8094.8 7522.1 8045.0 8099.6 8115.5 8137.5 7770.5 7785.9 7792.5 7803.9 7815.6 7573.8 7590.3 7592.6 7636.8 7669.3 6494.8 7693.4 8038.0 8068.6 8094.8 4693.3 4726.5 4738.6 4743.9 4754.7 5359.8 6092.5 7635.5 7695.7 7706.0 6228.7 7336.9 7353.0 7392.7 7403.0 5965.5 7100.2 7367.0 7370.5 7376.0 7183.0 7195.6 7196.1 7206.2 7274.9 5935.8 7400.8 7419.2 7425.6 7429.4 5921.0 6214.6 6866.0 7237.5 7318.8 10:03:57 INFO - PROCESS | 1672 | 10:03:57 INFO - PROCESS | 1672 | [#5] yui.html Cycles:180 Average:17529.66 Median:607.74 stddev:24109.83 (3967.1%) stddev-sans-first:24144.24 10:03:57 INFO - PROCESS | 1672 | Values: 673.3 730.1 736.6 741.4 768.9 14532.8 14684.9 14783.1 14805.4 14813.4 13565.8 13616.3 13641.7 13643.5 13678.6 806.7 840.1 841.8 847.5 848.5 822.3 830.6 833.6 834.9 842.3 851.5 873.3 879.8 880.7 882.5 858.8 863.0 872.2 874.4 874.6 522.3 625.9 636.8 644.9 646.6 14950.8 15177.4 15181.2 15208.8 15227.0 11890.6 12307.7 12385.1 12543.4 12569.7 10763.9 10858.3 10911.6 11052.8 11104.0 3391.9 3395.8 3463.5 3473.4 3533.9 70396.9 76756.7 81200.0 81353.0 81737.6 9183.1 9302.3 9349.7 9378.3 9601.7 16239.8 19695.3 19949.7 20010.0 20060.5 7352.3 7415.6 7433.3 7459.8 7517.9 3509.4 3527.3 3534.9 3549.0 3580.1 3524.3 3554.2 3559.2 3573.0 3573.3 664.0 672.4 673.6 675.0 676.0 498.3 515.0 541.7 593.5 611.9 6751.8 7379.3 8168.4 8286.8 8336.3 596.3 599.7 600.4 602.4 603.6 3784.5 3809.4 3834.5 3995.8 4014.0 63600.0 77499.0 78956.0 79499.0 79844.6 71196.6 73916.2 75067.6 75104.0 75123.0 48963.8 67043.7 67145.0 67226.7 69450.7 8472.7 8512.9 8573.4 8584.4 8630.5 47122.4 47375.5 48095.3 48226.5 49538.8 72865.3 74114.6 74717.6 74889.0 75140.0 10633.9 10715.2 10772.3 10895.1 11065.5 11615.0 11867.2 12291.7 12307.3 12563.2 11272.2 11489.9 11567.3 11619.9 11792.2 11195.2 11265.3 11291.4 11467.3 12013.8 10875.2 11597.1 11908.9 11926.3 12017.3 9242.7 9586.5 9708.8 9832.5 9961.5 7794.2 8257.8 9498.0 9760.6 9870.8 10:03:57 INFO - PROCESS | 1672 | -------- Summary: end -------- 10:03:57 INFO - PROCESS | 1672 | 10:03:57 INFO - TEST-INFO | 1672: exit 0 10:03:57 INFO - TEST-OK | dromaeo_css | took 1110991ms 10:03:57 INFO - TEST-START | kraken 10:03:57 INFO - operating with platform_type : mac_ 10:03:57 INFO - Initialising browser for kraken test... 10:03:57 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmp1htrXk/profile http://localhost:49278/getInfo.html) 10:04:00 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 10:04:00 INFO - PROCESS | 1680 | colorDepth:24 10:04:00 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 10:04:00 INFO - PROCESS | 1680 | __metrics 10:04:00 ERROR - PROCESS | 1680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 10:04:01 INFO - TEST-INFO | 1680: exit 0 10:04:01 INFO - Browser initialized. 10:04:01 INFO - Running cycle 1/1 for kraken test... 10:04:01 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmp1htrXk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:04:13 INFO - PROCESS | 1683 | RSS: Main: 256512000 10:04:13 INFO - PROCESS | 1683 | 10:04:16 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 10:04:16 INFO - PROCESS | 1683 | RSS: Main: 269508608 10:04:16 INFO - PROCESS | 1683 | 10:04:19 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 10:04:20 INFO - PROCESS | 1683 | RSS: Main: 277131264 10:04:20 INFO - PROCESS | 1683 | 10:04:23 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 10:04:23 INFO - PROCESS | 1683 | RSS: Main: 281300992 10:04:23 INFO - PROCESS | 1683 | 10:04:25 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 10:04:26 INFO - PROCESS | 1683 | RSS: Main: 283328512 10:04:26 INFO - PROCESS | 1683 | 10:04:28 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:04:29 INFO - PROCESS | 1683 | RSS: Main: 284119040 10:04:29 INFO - PROCESS | 1683 | 10:04:31 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 10:04:32 INFO - PROCESS | 1683 | RSS: Main: 284770304 10:04:32 INFO - PROCESS | 1683 | 10:04:35 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 10:04:35 INFO - PROCESS | 1683 | RSS: Main: 283529216 10:04:35 INFO - PROCESS | 1683 | 10:04:38 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 10:04:39 INFO - PROCESS | 1683 | RSS: Main: 284278784 10:04:39 INFO - PROCESS | 1683 | 10:04:41 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:04:41 INFO - PROCESS | 1683 | RSS: Main: 283922432 10:04:41 INFO - PROCESS | 1683 | 10:04:43 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:04:44 INFO - PROCESS | 1683 | RSS: Main: 282374144 10:04:44 INFO - PROCESS | 1683 | 10:04:46 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:04:46 INFO - PROCESS | 1683 | RSS: Main: 283611136 10:04:46 INFO - PROCESS | 1683 | 10:04:49 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:04:50 INFO - PROCESS | 1683 | RSS: Main: 282755072 10:04:50 INFO - PROCESS | 1683 | 10:04:52 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:04:53 INFO - PROCESS | 1683 | RSS: Main: 284622848 10:04:53 INFO - PROCESS | 1683 | 10:04:54 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 10:04:55 INFO - PROCESS | 1683 | RSS: Main: 285532160 10:04:55 INFO - PROCESS | 1683 | 10:04:55 INFO - PROCESS | 1683 | __start_tp_report 10:04:55 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 10:04:55 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 10:04:55 INFO - PROCESS | 1683 | |i|pagename|runs| 10:04:55 INFO - PROCESS | 1683 | |0;ai-astar;114;109;115;117;117;128;114;115;116;116 10:04:55 INFO - PROCESS | 1683 | |1;audio-beat-detection;156;123;139;185;171;134;173;151;190;124 10:04:55 INFO - PROCESS | 1683 | |2;audio-dft;194;198;201;207;264;196;202;198;205;200 10:04:55 INFO - PROCESS | 1683 | |3;audio-fft;56;64;75;75;63;122;59;61;63;58 10:04:55 INFO - PROCESS | 1683 | |4;audio-oscillator;80;86;116;79;90;65;119;117;122;158 10:04:55 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;85;92;84;91;88;91;86;92;85;92 10:04:55 INFO - PROCESS | 1683 | |6;imaging-darkroom;95;95;94;96;107;123;95;98;95;95 10:04:55 INFO - PROCESS | 1683 | |7;imaging-desaturate;93;121;145;107;90;92;90;95;147;144 10:04:55 INFO - PROCESS | 1683 | |8;json-parse-financial;54;52;53;56;59;58;58;66;60;57 10:04:55 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;67;66;72;72;75;75;91;63;80;102 10:04:55 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;88;84;87;90;86;85;86;89;87;88 10:04:55 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;126;135;133;132;113;133;116;138;122;138 10:04:55 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;186;177;144;143;145;145;144;184;146;140 10:04:55 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;70;67;68;68;69;66;69;69;70;70 10:04:55 INFO - PROCESS | 1683 | __end_tp_report 10:04:55 INFO - PROCESS | 1683 | __start_cc_report 10:04:55 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,902 10:04:55 INFO - PROCESS | 1683 | __end_cc_report 10:04:55 INFO - PROCESS | 1683 | __startTimestamp1456509895246__endTimestamp 10:04:55 INFO - PROCESS | 1683 | 10:04:55 INFO - PROCESS | 1683 | ------- Summary: start ------- 10:04:55 INFO - PROCESS | 1683 | Number of tests: 14 10:04:55 INFO - PROCESS | 1683 | 10:04:55 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:116.10 Median:116.00 stddev:4.77 (4.1%) stddev-sans-first:5.00 10:04:55 INFO - PROCESS | 1683 | Values: 114.0 109.0 115.0 117.0 117.0 128.0 114.0 115.0 116.0 116.0 10:04:55 INFO - PROCESS | 1683 | 10:04:55 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:154.60 Median:163.50 stddev:24.50 (15.0%) stddev-sans-first:25.98 10:04:55 INFO - PROCESS | 1683 | Values: 156.0 123.0 139.0 185.0 171.0 134.0 173.0 151.0 190.0 124.0 10:04:55 INFO - PROCESS | 1683 | 10:04:55 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:206.50 Median:201.50 stddev:20.58 (10.2%) stddev-sans-first:21.33 10:04:55 INFO - PROCESS | 1683 | Values: 194.0 198.0 201.0 207.0 264.0 196.0 202.0 198.0 205.0 200.0 10:04:55 INFO - PROCESS | 1683 | 10:04:55 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:69.60 Median:63.00 stddev:19.52 (31.0%) stddev-sans-first:20.07 10:04:55 INFO - PROCESS | 1683 | Values: 56.0 64.0 75.0 75.0 63.0 122.0 59.0 61.0 63.0 58.0 10:04:55 INFO - PROCESS | 1683 | 10:04:55 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:72.00 stddev:27.92 (38.8%) stddev-sans-first:28.32 10:04:55 INFO - PROCESS | 1683 | Values: 80.0 86.0 116.0 79.0 90.0 65.0 119.0 117.0 122.0 158.0 10:04:55 INFO - PROCESS | 1683 | 10:04:55 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:88.60 Median:91.00 stddev:3.34 (3.7%) stddev-sans-first:3.28 10:04:55 INFO - PROCESS | 1683 | Values: 85.0 92.0 84.0 91.0 88.0 91.0 86.0 92.0 85.0 92.0 10:04:55 INFO - PROCESS | 1683 | 10:04:55 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:99.30 Median:95.00 stddev:9.15 (9.6%) stddev-sans-first:9.58 10:04:55 INFO - PROCESS | 1683 | Values: 95.0 95.0 94.0 96.0 107.0 123.0 95.0 98.0 95.0 95.0 10:04:55 INFO - PROCESS | 1683 | 10:04:55 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:112.40 Median:90.00 stddev:24.63 (27.4%) stddev-sans-first:25.11 10:04:55 INFO - PROCESS | 1683 | Values: 93.0 121.0 145.0 107.0 90.0 92.0 90.0 95.0 147.0 144.0 10:04:55 INFO - PROCESS | 1683 | 10:04:55 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:58.00 stddev:4.03 (6.9%) stddev-sans-first:4.09 10:04:55 INFO - PROCESS | 1683 | Values: 54.0 52.0 53.0 56.0 59.0 58.0 58.0 66.0 60.0 57.0 10:04:55 INFO - PROCESS | 1683 | 10:04:55 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:76.30 Median:73.50 stddev:12.02 (16.4%) stddev-sans-first:12.27 10:04:55 INFO - PROCESS | 1683 | Values: 67.0 66.0 72.0 72.0 75.0 75.0 91.0 63.0 80.0 102.0 10:04:55 INFO - PROCESS | 1683 | 10:04:55 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:87.50 stddev:1.83 (2.1%) stddev-sans-first:1.90 10:04:55 INFO - PROCESS | 1683 | Values: 88.0 84.0 87.0 90.0 86.0 85.0 86.0 89.0 87.0 88.0 10:04:55 INFO - PROCESS | 1683 | 10:04:55 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:133.00 stddev:8.95 (6.7%) stddev-sans-first:9.44 10:04:55 INFO - PROCESS | 1683 | Values: 126.0 135.0 133.0 132.0 113.0 133.0 116.0 138.0 122.0 138.0 10:04:55 INFO - PROCESS | 1683 | 10:04:55 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.40 Median:145.50 stddev:18.79 (12.9%) stddev-sans-first:16.34 10:04:55 INFO - PROCESS | 1683 | Values: 186.0 177.0 144.0 143.0 145.0 145.0 144.0 184.0 146.0 140.0 10:04:55 INFO - PROCESS | 1683 | 10:04:55 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.35 (2.0%) stddev-sans-first:1.33 10:04:55 INFO - PROCESS | 1683 | Values: 70.0 67.0 68.0 68.0 69.0 66.0 69.0 69.0 70.0 70.0 10:04:55 INFO - PROCESS | 1683 | -------- Summary: end -------- 10:04:55 INFO - PROCESS | 1683 | 10:04:55 INFO - TEST-INFO | 1683: exit 0 10:04:56 INFO - TEST-OK | kraken | took 58136ms 10:04:56 INFO - SUITE-END | took 1169s 10:04:56 INFO - Completed test suite (00:19:29) 10:04:56 INFO - Working with test: dromaeo_css 10:04:56 INFO - Generating results file: dromaeo_css 10:04:56 INFO - Working with test: kraken 10:04:56 INFO - Generating results file: kraken 10:04:56 INFO - javascript benchmark 10:04:56 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:04:56 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 10:04:56 INFO - process_Request line: dromaeo_css 7409.89 graph.html#tests=[[72,64,61]] 10:04:56 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:04:56 INFO - process_Request line: kraken 1523.50 graph.html#tests=[[232,64,61]] 10:04:56 INFO - RETURN: dromaeo_css: 7409.89 10:04:56 INFO - RETURN: kraken: 1523.50 10:04:56 INFO - javascript benchmark 10:04:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3442.7934323940567, 3508.2808024354995, 3537.310224506219, 3559.1813882806955, 3568.7858728476294, 5098.694078355301, 5695.145728140781, 5704.172894930238, 5709.828705138847, 5741.282339707536, 5577.944220557793, 5640.153976903466, 5704.914426283599, 5729.484346408823, 5729.914051289234, 4917.311576379309, 5104.412992505853, 5165.457626949173, 5196.220566914974, 5257.395399529046, 5159.948400515985, 5305.973470132644, 5313.282706834567, 5318.228856815759, 5324.307839980797, 5123.743812809382, 5124.692518448867, 5180.352455943007, 5193.9740301298625, 5261.316028916254, 5166.715830629314, 5167.302414174076, 5190.403103643054, 5199.766010529535, 5208.427073021964, 5119.360079990001, 5134.537891589737, 5162.819301324435, 5181.378234611833, 5225.686458812484, 4720.693154944917, 5569.415211402826, 5574.470425309589, 5639.548836093103, 5675.858103547403, 6128.172696685935, 6130.325664176981, 6141.477974372184, 6149.016157414792, 6180.165677633507, 6182.103594978747, 6186.536009799238, 6186.876262474771, 6213.875722485525, 6218.0, 5658.490735833795, 5702.942970570324, 5800.303963524404, 5804.970975145097, 5845.210896528999, 6243.605420108321, 6264.561480696399, 6270.561060725797, 6275.529335299871, 6288.5283603728985, 5984.401559844068, 6128.380904898417, 6133.891171610156, 6139.9828168395225, 6144.9553575892205, 6142.355052719489, 6143.818944274807, 6212.161358216673, 6220.471259942865, 6247.125402443661, 6052.334243233241, 6074.878502429927, 6094.644720354235, 6112.685862051835, 6184.752609895554, 6154.076888466766, 6173.382661733791, 6205.348438413902, 6207.193064901534, 6224.097505861625, 4808.8797780055775, 4888.5111488850835, 4899.461059283547, 4908.190148625436, 4940.061388336277, 3236.838158092086, 3962.5443074046852, 4340.544242854455, 4347.347897815353, 4377.78111094444, 4829.299751536078, 5699.914501282484, 5777.653340799481, 5800.738966746507, 5820.738066787005, 6151.138840562325, 6164.8767024659255, 6169.784057557964, 6189.257289125334, 6195.256569211723, 4812.759362031885, 5804.82585522435, 5836.095405212199, 5855.765769369263, 5866.73599688015, 5267.525922666901, 5334.626576139711, 5357.276767636397, 5365.302510673588, 5377.838664840061, 6328.936710632835, 6399.9040014399825, 6412.839679007969, 6413.486921046305, 6442.2591401989375, 6202.472789812917, 6206.844828879314, 6215.005599104122, 6219.129321894848, 6224.470919971853, 6144.494598823317, 6264.5614806964895, 6341.112244285711, 6373.6175829450385, 6428.903566446601, 6092.886012546767, 6101.005087479836, 6101.297630694255, 6102.481289090477, 6134.957077261001, 4849.878753031061, 6142.740738148758, 6155.0, 6163.3836616338, 6174.197354343906, 5998.310194327708, 6040.426159514839, 6098.522998456991, 6109.0, 6112.633242005494, 4513.029698614813, 5154.433012368711, 5995.160677505066, 6049.848753781191, 6097.634141951497, 5266.262723218829, 5381.546982314675, 5802.0, 5895.41045895407, 5907.143464197753, 6029.306629737636, 6054.606450580698, 6057.57596968208, 6094.847628809315, 6143.232095988002, 5959.374265702212, 5967.582269241111, 5990.7304171311525, 6012.128241405059, 6018.488428483628], "unit": "score", "name": "dojo.html", "value": 5628.590600227556}, {"lowerIsBetter": false, "replicates": [453.5283305362423, 472.9217384363651, 473.50991723566113, 535.6464733276039, 553.9806755569751, 36011.4598281026, 36610.633893661055, 36666.81666591667, 36715.449268261, 36749.632503674955, 37378.62621373786, 37749.433758493644, 37943.430848537224, 38299.23401531968, 38355.80822095893, 9133.954330228356, 9341.299402544802, 9355.251579873593, 9357.204637605812, 9423.10480504351, 9238.769030774218, 9502.619895204218, 9524.80950380992, 9528.38065525742, 9554.665586704466, 9466.574004169794, 9542.475163865985, 9559.426434413923, 9571.234301255918, 9578.808423831519, 9478.052194780536, 9526.761830954247, 9538.141567258945, 9564.66523671668, 9594.04059594042, 9304.67433639826, 9446.38598491096, 9452.43285402878, 9459.621615135386, 9484.19384352331, 36404.27191456156, 36644.26711465756, 36700.0, 36929.26141477156, 37105.44341834875, 3105.332353543999, 3155.8737650493954, 3189.3940151371166, 3335.0828522156357, 3535.398982173011, 27518.0, 27822.582661260098, 27835.02577409781, 28240.576391354145, 28442.71557284442, 2585.5391703687546, 2616.6205900144373, 2736.0834120569634, 2741.821781584191, 2753.7796976241852, 393717.0, 394271.0, 397393.0260697385, 399584.9999999971, 399661.0, 51017.97964040773, 59912.10131848026, 61189.0, 61280.69359653173, 61305.38694613086, 66848.0, 67580.66209668921, 68164.6591767048, 69019.65490172517, 69237.65381173062, 15945.282462288993, 16048.518544443685, 16091.195440227943, 16146.838531614534, 16168.43410480651, 12226.816597751042, 12348.629541113782, 12377.504899803907, 12412.62762117138, 12489.875101249054, 19740.0, 20049.59900801976, 20149.19403223884, 20154.193832246838, 20165.596688066158, 8650.567471626393, 8900.910990890137, 8909.331800115016, 8931.642734290555, 8948.239399650973, 942.5193151492651, 956.4404823178379, 982.2976571751232, 1056.0970370333255, 1063.8670166229222, 27985.72014279872, 28720.856395718307, 28952.27619309492, 29217.41565168727, 29297.267568310537, 1057.7990181865575, 1061.5117046158853, 1078.7734575739025, 1096.6216655253925, 1100.273819279272, 13288.534901278408, 13992.0, 14864.925675371554, 14908.235294117647, 15084.396624134912, 514066.8593314094, 519307.0, 521295.0, 525618.0, 528751.0, 55864.441355586736, 56047.0, 56402.153967690516, 56620.71689641525, 56969.43030569641, 1342.7515909556764, 1374.5738820965532, 1380.1374141161773, 1399.664080620664, 1406.7749160134329, 24139.0, 24148.63777043381, 27582.724172758015, 30260.0, 30598.694013059583, 50965.745171273906, 51010.489895100574, 51418.971620568125, 51494.742526287126, 51735.0, 487588.0, 492249.0, 506058.0, 506400.0, 507659.0, 38493.80753096216, 39856.800715996236, 41838.79080604578, 42598.361024585276, 43028.56971430246, 44019.0, 44355.77822110869, 45269.0, 45429.77285113553, 45594.54405455903, 36940.63059369372, 37428.81285593555, 37542.624573755005, 37697.05757356088, 37705.0, 36550.45174322334, 36729.26541469209, 36833.63166368409, 36930.0, 37337.81331093327, 36240.81879590585, 36565.0, 36858.0, 37252.62747372492, 37409.0, 27640.723592763814, 27702.307442314104, 27912.86043569769, 28682.42635147327, 28858.42283154367, 22689.092436302362, 24887.87556062208, 25113.372165695273, 25334.746652533977, 25451.74548254494], "unit": "score", "name": "ext.html", "value": 19387.611938295733}, {"lowerIsBetter": false, "replicates": [347.23954539558383, 349.36241359518874, 354.6612984599707, 361.98733044343453, 362.07309288222154, 16081.839181608195, 18310.809797363163, 18691.813081869193, 20161.99190040496, 20289.898550507263, 19162.329318473858, 19645.017749112558, 20246.29137980171, 20332.59334813303, 20347.0, 5709.143628455723, 6012.9398706013035, 6030.788922387717, 6035.849103772419, 6039.516838652898, 4199.4120823084795, 5878.50032747217, 6229.563930524865, 6506.121673574078, 6532.0201969704685, 6453.354664533533, 6456.2575303840185, 6464.353564643545, 6479.157709497782, 6495.967520162416, 5514.862128446801, 5781.161731548902, 5783.768649254025, 5804.651720896739, 5809.622374545641, 5450.796401996237, 5452.972735136299, 5547.25112109864, 5589.273394458735, 5599.300087489064, 10661.200409969284, 10974.725631859188, 13318.267495287755, 13376.063675542717, 13513.86486135136, 1841.5488205389631, 1933.1397528100001, 2167.360628614547, 2232.386093824195, 2436.7075950886006, 9260.953695231481, 9575.952120239424, 9695.757606059835, 9705.417674939526, 9818.165455936254, 1664.941727039548, 1693.0857337037985, 1735.8524525415355, 1738.3307426640833, 1790.8030116687285, 99034.50482747612, 101304.0, 103187.48406257921, 105916.47041764742, 108966.0, 10687.78624427507, 10977.451127443595, 11233.943830280796, 11239.887601124048, 11333.886661133449, 13326.93336533311, 13339.132956357806, 13358.599242022754, 13367.264800435874, 13458.192508449329, 7183.568985860865, 7511.985881905982, 8333.708320208885, 8403.327733781283, 8492.193241642035, 8320.417570770109, 8506.276966457921, 8589.0, 8612.18184272493, 8621.568921553897, 4417.933730994037, 4460.107978404268, 4460.799264033127, 4471.396361491157, 4492.146492166478, 1464.7729601911722, 1696.380821000326, 1810.2035104554218, 1865.2445759467166, 1900.4963684623585, 871.4640496094983, 934.3926447808842, 950.6910254167424, 994.9801453510065, 1009.9141572966233, 13885.652858678412, 15482.845171548366, 16571.585710357336, 20062.699059514118, 20063.29778457747, 884.8539990901558, 906.0, 932.8973812880578, 963.8843338799389, 987.5802783816849, 10174.389536627827, 10599.364038157735, 10604.416757078434, 10630.468476576294, 10765.569377224823, 639592.0, 646666.7666661637, 653623.0, 658652.0, 665404.0, 92314.0, 100921.0, 123906.0, 127310.0, 129841.0, 1026.14829691356, 1029.5933106422922, 1039.262123892045, 1041.953112109957, 1047.157038583932, 17307.0, 17365.913170434065, 17389.304427823252, 17421.564460888072, 17754.91122544379, 37328.81335593413, 45915.31127033164, 46359.768201158775, 48991.51008489869, 51361.0, 44774.0, 74082.62958685172, 75114.62442687752, 75565.62217188878, 77261.22738772765, 7680.347170490348, 7841.137474877645, 8065.838683226185, 8127.674893004214, 8184.7953801155445, 7618.923810762043, 8876.979147398131, 11278.887211127783, 12719.364031798188, 13075.738485230051, 11301.26541774782, 11338.659840204808, 11455.656330310105, 11488.483018264365, 11930.22453540517, 9284.210842078499, 11125.388103654377, 11133.220674552704, 11522.308661480338, 11764.529418823151, 10985.560577576807, 11519.136064795006, 11547.480363383836, 11689.941550292195, 11770.882291176978, 8073.959630201812, 8150.796230094295, 8160.8367832641825, 8467.61895714682, 8474.110218426977, 10758.46207689628, 10878.23852330361, 11505.137114716263, 11508.654740357802, 11811.17321787501], "unit": "score", "name": "jquery.html", "value": 9050.764832325924}, {"lowerIsBetter": false, "replicates": [1519.9588282026812, 1539.5843122356964, 1547.736884729596, 1871.15797890949, 1871.4479228627554, 7847.176046515119, 8502.872456913152, 8589.141085891408, 8818.809460722809, 8830.77923051924, 6480.513961452886, 8269.635510140819, 8525.658973641046, 8571.271441927443, 8588.785280367978, 2441.9389515262174, 2453.055573604162, 2464.667269918565, 2473.628955656648, 2474.6288056791445, 2416.66166736657, 2481.838680485772, 2484.142970675114, 2484.2050543825985, 2488.4276616378243, 2441.6215486599604, 2452.5708001099824, 2492.5638013347593, 2492.950140997188, 2494.625806129086, 2446.4984678141027, 2470.950580988379, 2481.131603938616, 2483.888225029878, 2489.4523204894895, 2034.4201902457728, 2439.3413778279764, 2471.369800700828, 2478.5662509060844, 2478.5910324796387, 7358.852822943565, 8761.123887611251, 8772.824543509158, 8778.29773618109, 8784.692535761218, 5300.92048619271, 5444.183372494118, 5445.156000819879, 5469.726513674301, 5470.0, 3440.0, 3442.087846720621, 3499.1427100360575, 3691.7600355977042, 3693.5752388475403, 1050.8686414198226, 1061.2571200159919, 1061.697416236369, 1062.654637242899, 1062.7077553672725, 11669.70825729355, 11709.765804683944, 11723.237989530653, 11736.061115110771, 11753.0, 3928.980355098206, 4825.372701548847, 4904.337914381585, 4942.20924652054, 4946.431160416598, 10038.899611003942, 10049.648262310784, 10053.296269261082, 10065.647702330383, 10111.797764044677, 5459.2902922619805, 5460.208269800936, 5481.479259470344, 5538.667679939216, 5571.526420254324, 4416.867493975186, 4830.492798256132, 4909.950900491021, 4966.329545511309, 4971.030649023406, 3869.032741814546, 3921.4117882317883, 3929.4891664084057, 3942.6648734857285, 3979.5025621797276, 1292.2440372382073, 1294.1070661243712, 1297.7858653322285, 1307.1438207973792, 1314.90795644304, 1084.8643919510062, 1105.4251789069638, 1122.3995162587976, 1348.3864841497095, 1365.5357178559339, 7980.241877021674, 8032.196780321921, 8109.553974531457, 8136.389770767216, 8142.389320800964, 508.1767536590747, 516.1741214057478, 517.2241637543684, 517.6635187128321, 518.0467938992273, 6125.663088530085, 6129.233845769279, 6163.537734669918, 6202.44178023971, 6233.96883015582, 10197.694069177936, 10492.108170805413, 10500.579976800842, 10595.0, 10681.679549613524, 10250.692479225636, 10391.636292729718, 10425.175594270971, 10494.947525262325, 10530.210234232463, 8209.05595856484, 8279.296259817862, 8280.99999999988, 8322.29260512851, 8375.45559538628, 7669.769906902802, 7680.155182929761, 7819.41354398411, 7826.960865195638, 7828.725994590162, 9290.62837486493, 9426.95286523563, 9491.240700743785, 9553.570089345858, 9645.662401815904, 9724.416535007922, 9864.260180486348, 9874.802503949737, 9887.357321774061, 9921.355111917703, 6487.870242595216, 7020.824479387852, 7392.96303518479, 7421.888671670037, 7461.850762984818, 8154.714584989497, 8155.9184408157535, 8174.182581741778, 8179.386546008954, 8267.62795674208, 7156.391706704989, 7202.89195662076, 7300.23347548521, 7324.08448943882, 7372.373348265458, 6420.06908998202, 6783.86432271342, 6863.279355667583, 7152.034475345762, 7270.600116993616, 7521.097468303619, 7573.886391704019, 7619.123800762984, 7629.961850190713, 7634.50375725576, 6120.265568131853, 6909.205441374306, 6927.134108236471, 6934.445244380337, 6987.615681137586, 6977.546459480118, 6992.61540615271, 7035.155781306276, 7070.611116388648, 7102.9289707104335], "unit": "score", "name": "mootools.html", "value": 4780.8618760496865}, {"lowerIsBetter": false, "replicates": [281.5171980054207, 327.5545258448511, 328.3728079368407, 329.9433465541171, 330.4811446029733, 5358.732063396834, 6650.501212409071, 6929.514933954612, 6965.6517174141345, 6970.546914450557, 6820.454363650909, 6839.316068393158, 6886.2080860701035, 6895.689693963771, 6896.344847239517, 4046.9680231540915, 4728.9290660639945, 4850.369451971239, 4931.753412329387, 5001.14980453322, 4941.851744447672, 4946.455889852114, 4964.05682920244, 4966.0, 4971.602271818246, 4928.704277743329, 4928.901421971558, 4935.432425271086, 4955.603551715854, 5001.8249361272365, 4932.506749325057, 4940.851774446773, 4952.628552858514, 4978.278149668277, 4987.47631498691, 3457.481377793326, 4247.638950689196, 4251.298535741599, 4257.744535327859, 4284.207421627009, 6206.596571222901, 6511.316311787242, 6512.413882750528, 6542.214934207926, 6552.574082684658, 4262.722923009995, 5717.971410142923, 5784.566157538159, 5784.681842498703, 5803.361630220672, 6478.2873883872735, 6792.218894827109, 7347.228541003225, 7347.816304592375, 7360.300771426706, 4579.969506860963, 4596.54034596541, 4611.492735799059, 4620.330052142421, 4637.559431853969, 5381.650192737459, 6136.9873970795215, 6796.592204467748, 7773.2226777322385, 7843.490173138728, 3979.383195604686, 4089.9182016359505, 4667.556582124693, 4714.316424118552, 4720.386349774507, 3727.6458736419995, 4591.9081618367445, 4759.50025247351, 4772.76136193189, 4779.259214821708, 5742.827715168552, 5743.4543718346695, 5753.913691294634, 5783.768649254067, 5784.21913041734, 7412.96293518529, 7430.071241094864, 7430.145533263636, 7450.888236676454, 7472.738454154079, 1650.4553497345846, 1671.6322409069985, 1672.3143511160365, 1672.4564516532175, 1673.238676402234, 1025.3386565665253, 1063.2716589136467, 1067.1356201476829, 1070.8500809886623, 1083.1010261483107, 6884.173899132036, 6897.137857767779, 6911.9308806912295, 6949.89575156373, 6990.440764738809, 5752.36723960364, 6047.637141771508, 7650.655720492591, 7656.578888161204, 7662.080550333884, 5609.943900560942, 6640.667966601651, 6810.0, 6924.6537673116145, 6954.374106330454, 4045.6763458923215, 4078.430588729141, 4082.2243773682903, 4092.2224777292217, 4097.938530922039, 8072.394570407126, 8079.070906845788, 8091.716789912325, 8092.514449133071, 8115.837683246302, 7686.269804368688, 7981.161977992343, 8010.959945200237, 8022.879656805153, 8094.797630059178, 7522.134954480195, 8045.0, 8099.635516401776, 8115.513069215866, 8137.471064380915, 7770.456068075407, 7785.92214077852, 7792.532448053135, 7803.882941755992, 7815.570143641927, 7573.810654733676, 7590.316871481593, 7592.582407967615, 7636.770896873103, 7669.309762121436, 6494.772682956074, 7693.422993275415, 8037.959810200911, 8068.59657017135, 8094.838103237785, 4693.272542755878, 4726.503717109654, 4738.573528382462, 4743.881402964954, 4754.7147171169845, 5359.839204823861, 6092.512598992159, 7635.503692259986, 7695.6921723130445, 7706.0, 6228.719707613259, 7336.853262934818, 7353.0441042664115, 7392.667329970272, 7403.037605111301, 5965.492933100735, 7100.218975912542, 7367.0, 7370.484066115535, 7376.0, 7182.96408517954, 7195.553511806011, 7196.136463624399, 7206.171290301682, 7274.927250727636, 5935.792247271324, 7400.777976660709, 7419.183889772229, 7425.628718563942, 7429.44279179053, 5920.970395147997, 6214.627122372672, 6866.004429357616, 7237.457190710823, 7318.780436586911], "unit": "score", "name": "prototype.html", "value": 5221.892945006613}, {"lowerIsBetter": false, "replicates": [673.2829536543582, 730.1019745712773, 736.6427282767856, 741.3809469093305, 768.8539177556268, 14532.78200826987, 14684.926575367135, 14783.113013219214, 14805.407783688639, 14813.407463701453, 13565.796513052312, 13616.319184040784, 13641.72716545671, 13643.522476713317, 13678.589642310746, 806.7297455352464, 840.1388576708891, 841.7643059943196, 847.5253857839599, 848.5248260973843, 822.3051521464353, 830.5681045856152, 833.6332013913889, 834.8872902158222, 842.2503971465401, 851.5401683091154, 873.2620935309653, 879.8152387998528, 880.7357792662208, 882.5322579033091, 858.8110615664543, 863.0290922711949, 872.2150064941603, 874.4272501511521, 874.606427107804, 522.3183745212497, 625.9029850373199, 636.7962252079336, 644.9387308205713, 646.615263917968, 14950.775738363933, 15177.392904283815, 15181.240937953058, 15208.771868421982, 15227.0, 11890.58382956601, 12307.69230769229, 12385.071119666061, 12543.435545400478, 12569.685757856036, 10763.892361076445, 10858.294210876267, 10911.618093366773, 11052.834207486894, 11104.000639942444, 3391.9491207631904, 3395.847186876572, 3463.5324231228715, 3473.4442489201606, 3533.893983180483, 70396.94404583935, 76756.7081127292, 81200.0, 81353.0, 81737.59131204366, 9183.081691830763, 9302.348835581444, 9349.672761453316, 9378.296627752945, 9601.663941762004, 16239.756403653955, 19695.310664126686, 19949.700754488695, 20009.99950002494, 20060.498487537636, 7352.301531354513, 7415.555066696015, 7433.293837085468, 7459.813504662427, 7517.924820751832, 3509.420945543957, 3527.2592755521114, 3534.8939531814085, 3549.0, 3580.051286409104, 3524.2599054198904, 3554.20030493137, 3559.1635965548076, 3573.0, 3573.3210689968823, 663.9900401493982, 672.4485921544384, 673.5520878615764, 675.0245894682137, 675.993240067593, 498.26505903791616, 515.047162748919, 541.7453796715538, 593.4866340615337, 611.9082137679295, 6751.763688270887, 7379.3358597726465, 8168.387370947203, 8286.792830179294, 8336.291415229773, 596.260636810352, 599.6971529377637, 600.4325912013193, 602.4006113916681, 603.5805115444812, 3784.545854497423, 3809.447630093621, 3834.482344883461, 3995.800209989489, 4013.959860401417, 63600.0, 77498.96256743406, 78956.0, 79499.0, 79844.60077699574, 71196.64401677958, 73916.15209619803, 75067.62466187743, 75104.0, 75123.0, 48963.75518122387, 67043.66478167675, 67145.0, 67226.66386668035, 69450.65274673696, 8472.661093556435, 8512.914870851213, 8573.442726222776, 8584.442011269248, 8630.482171069756, 47122.35071772608, 47375.52624473711, 48095.27857082216, 48226.5177348236, 49538.75230623968, 72865.27134728584, 74114.62942685468, 74717.62641186759, 74889.0, 75140.0, 10633.89366106329, 10715.196360272856, 10772.299800512941, 10895.128389728961, 11065.5020524075, 11615.012723918562, 11867.169298149392, 12291.69270768238, 12307.30917693936, 12563.18339307942, 11272.154588405738, 11489.942550287195, 11567.305961642329, 11619.883801161881, 11792.174547781917, 11195.160362972647, 11265.324080555192, 11291.3789741565, 11467.254628449124, 12013.81979270329, 10875.184361173102, 11597.130215233723, 11908.880911190778, 11926.344051076927, 12017.278963262232, 9242.676506322246, 9586.472743999147, 9708.75728106803, 9832.508374581384, 9961.452120133463, 7794.22057794216, 8257.83484330298, 9497.952510237405, 9760.609575616896, 9870.753231169278], "unit": "score", "name": "yui.html", "value": 6712.65659281414}], "name": "dromaeo_css", "value": 7409.895306001594}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 109.0, 115.0, 117.0, 117.0, 128.0, 114.0, 115.0, 116.0, 116.0], "unit": "score", "name": "ai-astar", "value": 116.1}, {"lowerIsBetter": true, "replicates": [156.0, 123.0, 139.0, 185.0, 171.0, 134.0, 173.0, 151.0, 190.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 154.6}, {"lowerIsBetter": true, "replicates": [194.0, 198.0, 201.0, 207.0, 264.0, 196.0, 202.0, 198.0, 205.0, 200.0], "unit": "score", "name": "audio-dft", "value": 206.5}, {"lowerIsBetter": true, "replicates": [56.0, 64.0, 75.0, 75.0, 63.0, 122.0, 59.0, 61.0, 63.0, 58.0], "unit": "score", "name": "audio-fft", "value": 69.6}, {"lowerIsBetter": true, "replicates": [80.0, 86.0, 116.0, 79.0, 90.0, 65.0, 119.0, 117.0, 122.0, 158.0], "unit": "score", "name": "audio-oscillator", "value": 103.2}, {"lowerIsBetter": true, "replicates": [85.0, 92.0, 84.0, 91.0, 88.0, 91.0, 86.0, 92.0, 85.0, 92.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 94.0, 96.0, 107.0, 123.0, 95.0, 98.0, 95.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 99.3}, {"lowerIsBetter": true, "replicates": [93.0, 121.0, 145.0, 107.0, 90.0, 92.0, 90.0, 95.0, 147.0, 144.0], "unit": "score", "name": "imaging-desaturate", "value": 112.4}, {"lowerIsBetter": true, "replicates": [54.0, 52.0, 53.0, 56.0, 59.0, 58.0, 58.0, 66.0, 60.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 72.0, 72.0, 75.0, 75.0, 91.0, 63.0, 80.0, 102.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 76.3}, {"lowerIsBetter": true, "replicates": [88.0, 84.0, 87.0, 90.0, 86.0, 85.0, 86.0, 89.0, 87.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.0}, {"lowerIsBetter": true, "replicates": [126.0, 135.0, 133.0, 132.0, 113.0, 133.0, 116.0, 138.0, 122.0, 138.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.6}, {"lowerIsBetter": true, "replicates": [186.0, 177.0, 144.0, 143.0, 145.0, 145.0, 144.0, 184.0, 146.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 155.4}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 68.0, 68.0, 69.0, 66.0, 69.0, 69.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1523.4999999999998}]} 10:04:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1523.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7409.89"}}} 10:04:56 INFO - Return code: 0 10:04:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:04:56 ERROR - # TBPL SUCCESS # 10:04:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:04:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:04:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:04:56 INFO - 2016-02-26 10:04:56.961 screenresolution[1688:10309] starting screenresolution argv=screenresolution get 10:04:56 INFO - 2016-02-26 10:04:56.964 screenresolution[1688:10309] Display 0: 1600x1200x32@60 10:04:56 INFO - 2016-02-26 10:04:56.970 screenresolution[1689:10312] starting screenresolution argv=screenresolution list 10:04:56 INFO - Available Modes on Display 0 10:04:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:04:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:04:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:04:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:04:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:04:57 INFO - Intel Iris: 10:04:57 INFO - Chipset Model: Intel Iris 10:04:57 INFO - Type: GPU 10:04:57 INFO - Bus: Built-In 10:04:57 INFO - VRAM (Dynamic, Max): 1536 MB 10:04:57 INFO - Vendor: Intel (0x8086) 10:04:57 INFO - Device ID: 0x0a2e 10:04:57 INFO - Revision ID: 0x0009 10:04:57 INFO - Displays: 10:04:57 INFO - Display: 10:04:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:04:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:04:57 INFO - Display Serial Number: 1600x1200 60 10:04:57 INFO - Main Display: Yes 10:04:57 INFO - Mirror: Off 10:04:57 INFO - Online: Yes 10:04:57 INFO - Rotation: Supported 10:04:57 INFO - Return code: 0 10:04:57 INFO - Running post-action listener: _resource_record_post_action 10:04:57 INFO - Running post-run listener: _resource_record_post_run 10:04:58 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 38888960; Write bytes: 708689920; Read time: 417; Write time: 1947 10:04:58 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 402960896; Write bytes: 392091648; Read time: 29969; Write time: 717 10:04:58 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 31809024; Write bytes: 300828672; Read time: 332; Write time: 1190 10:04:58 INFO - Running post-run listener: _upload_blobber_files 10:04:58 INFO - Blob upload gear active. 10:04:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:04:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:04:58 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'] 10:04:58 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 10:04:58 INFO - (blobuploader) - INFO - Open directory for files ... 10:04:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:04:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:04:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:05:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:00 INFO - (blobuploader) - INFO - Done attempting. 10:05:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:05:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:05:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:01 INFO - (blobuploader) - INFO - Done attempting. 10:05:01 INFO - (blobuploader) - INFO - Iteration through files over. 10:05:01 INFO - Return code: 0 10:05:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:05:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:05:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1540df08dbc9463ec368056eab4aad58390c922f4068a3d2b40d050d6b3b28d3e3df3a6b84d915879497ced0c604ae935fc33b968e42b8738f7c760ff2127ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54094d787a63bc70dbde2d5358efcafb1b26a6ee892324b33748b941e706caa4c75613f8db661dcd1c2c941330bb4c9d470c7b7b2dbdb9fd3e30602c32693002"} 10:05:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:05:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:05:01 INFO - Contents: 10:05:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1540df08dbc9463ec368056eab4aad58390c922f4068a3d2b40d050d6b3b28d3e3df3a6b84d915879497ced0c604ae935fc33b968e42b8738f7c760ff2127ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54094d787a63bc70dbde2d5358efcafb1b26a6ee892324b33748b941e706caa4c75613f8db661dcd1c2c941330bb4c9d470c7b7b2dbdb9fd3e30602c32693002"} 10:05:01 INFO - Running post-run listener: copy_logs_to_upload_dir 10:05:01 INFO - Copying logs to upload dir... 10:05:01 INFO - mkdir: /builds/slave/test/build/upload/logs 10:05:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.696973 ========= master_lag: 13.32 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-02-26 10:05:14.992912) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 18 secs) (at 2016-02-26 10:05:14.996372) ========= 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.XdoLjpefIM/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.WxwYKcOJmy/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1540df08dbc9463ec368056eab4aad58390c922f4068a3d2b40d050d6b3b28d3e3df3a6b84d915879497ced0c604ae935fc33b968e42b8738f7c760ff2127ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54094d787a63bc70dbde2d5358efcafb1b26a6ee892324b33748b941e706caa4c75613f8db661dcd1c2c941330bb4c9d470c7b7b2dbdb9fd3e30602c32693002"} build_url:https://queue.taskcluster.net/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011090 build_url: 'https://queue.taskcluster.net/v1/task/b0wpXsfLTPqKsOCfcxRvwA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1540df08dbc9463ec368056eab4aad58390c922f4068a3d2b40d050d6b3b28d3e3df3a6b84d915879497ced0c604ae935fc33b968e42b8738f7c760ff2127ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54094d787a63bc70dbde2d5358efcafb1b26a6ee892324b33748b941e706caa4c75613f8db661dcd1c2c941330bb4c9d470c7b7b2dbdb9fd3e30602c32693002"}' ========= master_lag: 18.89 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 18 secs) (at 2016-02-26 10:05:33.901242) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 7 secs) (at 2016-02-26 10:05:33.901637) ========= 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.XdoLjpefIM/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.WxwYKcOJmy/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.005270 ========= master_lag: 7.16 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 7 secs) (at 2016-02-26 10:05:41.068866) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 10:05:41.069233) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 10:05:41.189895) ========= ========= Total master_lag: 39.53 =========