builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0096 starttime: 1455101422.82 results: success (0) buildid: 20160208164823 builduid: 30a40c8c361641e58b7426d55eb90c1e revision: 49945e5fe79e6cf2b083f56fd49d917ca886db0b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:22.822252) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:22.822700) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:22.822984) ========= 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.Y0wgwYSQiO/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.X1beQl2r6k/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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.005559 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:22.844686) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:22.844986) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:22.859990) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:22.860374) ========= 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.Y0wgwYSQiO/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.X1beQl2r6k/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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.004775 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:22.908868) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:22.909292) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:22.909752) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:22.910045) ========= 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.Y0wgwYSQiO/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.X1beQl2r6k/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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-10 02:50:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 43.5M=0s 2016-02-10 02:50:23 (43.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166115 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:23.091714) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:23.092137) ========= 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.Y0wgwYSQiO/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.X1beQl2r6k/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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.019376 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:23.141567) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-10 02:50:23.141972) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 49945e5fe79e6cf2b083f56fd49d917ca886db0b --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 49945e5fe79e6cf2b083f56fd49d917ca886db0b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Y0wgwYSQiO/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.X1beQl2r6k/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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-10 02:50:23,215 truncating revision to first 12 chars 2016-02-10 02:50:23,215 Setting DEBUG logging. 2016-02-10 02:50:23,215 attempt 1/10 2016-02-10 02:50:23,216 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/49945e5fe79e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-10 02:50:24,726 unpacking tar archive at: fx-team-49945e5fe79e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.756570 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-10 02:50:24.915061) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:24.915538) ========= echo 49945e5fe79e6cf2b083f56fd49d917ca886db0b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'49945e5fe79e6cf2b083f56fd49d917ca886db0b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Y0wgwYSQiO/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.X1beQl2r6k/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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 49945e5fe79e6cf2b083f56fd49d917ca886db0b program finished with exit code 0 elapsedTime=0.004927 script_repo_revision: '49945e5fe79e6cf2b083f56fd49d917ca886db0b' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:24.965328) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:24.965674) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:24.978223) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-02-10 02:50:24.978628) ========= /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.Y0wgwYSQiO/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.X1beQl2r6k/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:50:25 INFO - MultiFileLogger online at 20160210 02:50:25 in /builds/slave/test 02:50:25 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 02:50:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:50:25 INFO - {'append_to_log': False, 02:50:25 INFO - 'base_work_dir': '/builds/slave/test', 02:50:25 INFO - 'blob_upload_branch': 'Fx-Team', 02:50:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:50:25 INFO - 'branch': 'Fx-Team', 02:50:25 INFO - 'buildbot_json_path': 'buildprops.json', 02:50:25 INFO - 'config_files': ('talos/mac_config.py',), 02:50:25 INFO - 'default_actions': ('clobber', 02:50:25 INFO - 'read-buildbot-config', 02:50:25 INFO - 'download-and-extract', 02:50:25 INFO - 'populate-webroot', 02:50:25 INFO - 'create-virtualenv', 02:50:25 INFO - 'install', 02:50:25 INFO - 'run-tests'), 02:50:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:50:25 INFO - 'download_minidump_stackwalk': True, 02:50:25 INFO - 'download_symbols': 'ondemand', 02:50:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:50:25 INFO - 'tooltool.py': '/tools/tooltool.py', 02:50:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:50:25 INFO - '/tools/misc-python/virtualenv.py')}, 02:50:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:50:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:50:25 INFO - 'installer_path': 'installer.exe', 02:50:25 INFO - 'log_level': 'info', 02:50:25 INFO - 'log_name': 'talos', 02:50:25 INFO - 'log_to_console': True, 02:50:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:50:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:50:25 INFO - 'opt_config_files': (), 02:50:25 INFO - 'pip_index': False, 02:50:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:50:25 INFO - 'cmd': ('bash', 02:50:25 INFO - '-c', 02:50:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:50:25 INFO - 'enabled': True, 02:50:25 INFO - 'halt_on_failure': False, 02:50:25 INFO - 'name': 'check_screen_resolution'},), 02:50:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:50:25 INFO - 'cmd': ('bash', 02:50:25 INFO - '-c', 02:50:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:50:25 INFO - 'enabled': True, 02:50:25 INFO - 'halt_on_failure': False, 02:50:25 INFO - 'name': 'check_screen_resolution'},), 02:50:25 INFO - 'run_cmd_checks_enabled': True, 02:50:25 INFO - 'sps_profile': False, 02:50:25 INFO - 'sps_profile_interval': 0, 02:50:25 INFO - 'suite': 'dromaeojs-e10s', 02:50:25 INFO - 'system_bits': '32', 02:50:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:50:25 INFO - 'title': 't-yosemite-r7-0096', 02:50:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:50:25 INFO - 'use_talos_json': True, 02:50:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:50:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:50:25 INFO - 'work_dir': 'build'} 02:50:25 INFO - ##### 02:50:25 INFO - ##### Running clobber step. 02:50:25 INFO - ##### 02:50:25 INFO - Running pre-action listener: _resource_record_pre_action 02:50:25 INFO - Running main action method: clobber 02:50:25 INFO - rmtree: /builds/slave/test/build 02:50:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:50:25 INFO - Running post-action listener: _resource_record_post_action 02:50:25 INFO - ##### 02:50:25 INFO - ##### Running read-buildbot-config step. 02:50:25 INFO - ##### 02:50:25 INFO - Running pre-action listener: _resource_record_pre_action 02:50:25 INFO - Running main action method: read_buildbot_config 02:50:25 INFO - Using buildbot properties: 02:50:25 INFO - { 02:50:25 INFO - "project": "", 02:50:25 INFO - "product": "firefox", 02:50:25 INFO - "script_repo_revision": "production", 02:50:25 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 02:50:25 INFO - "repository": "", 02:50:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 02:50:25 INFO - "buildid": "20160208164823", 02:50:25 INFO - "pgo_build": "False", 02:50:25 INFO - "basedir": "/builds/slave/test", 02:50:25 INFO - "buildnumber": 338, 02:50:25 INFO - "slavename": "t-yosemite-r7-0096", 02:50:25 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:50:25 INFO - "platform": "yosemite_r7", 02:50:25 INFO - "scheduler": "tests-fx-team-macosx64-talos", 02:50:25 INFO - "branch": "fx-team", 02:50:25 INFO - "repo_path": "integration/fx-team", 02:50:25 INFO - "revision": "49945e5fe79e6cf2b083f56fd49d917ca886db0b", 02:50:25 INFO - "stage_platform": "macosx64", 02:50:25 INFO - "builduid": "30a40c8c361641e58b7426d55eb90c1e", 02:50:25 INFO - "slavebuilddir": "test" 02:50:25 INFO - } 02:50:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 02:50:25 INFO - Running post-action listener: _resource_record_post_action 02:50:25 INFO - ##### 02:50:25 INFO - ##### Running download-and-extract step. 02:50:25 INFO - ##### 02:50:25 INFO - Running pre-action listener: _resource_record_pre_action 02:50:25 INFO - Running main action method: download_and_extract 02:50:25 INFO - mkdir: /builds/slave/test/build/tests 02:50: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')]} 02:50:25 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:50:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json 02:50:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json 02:50:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:50:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:50:26 INFO - Downloaded 1277 bytes. 02:50:26 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:50:26 INFO - Using the following test package requirements: 02:50:26 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:50:26 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:50:26 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 02:50:26 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:50:26 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 02:50:26 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:50:26 INFO - u'jsshell-mac.zip'], 02:50:26 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:50:26 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 02:50:26 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:50:26 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:50:26 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 02:50:26 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:50:26 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 02:50:26 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:50:26 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 02:50:26 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:50:26 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:50:26 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 02:50:26 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:50:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:26 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:50:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:50:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:50:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:50:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:50:27 INFO - Downloaded 17753849 bytes. 02:50:27 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'] 02:50:27 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 02:50:30 INFO - Return code: 0 02:50:30 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 02:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:30 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:50:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:50:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:50:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:50:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:50:31 INFO - Downloaded 17753849 bytes. 02:50:31 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'] 02:50:31 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 02:50:35 INFO - Return code: 0 02:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:35 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:50:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 02:50:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 02:50:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:50:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:50:36 INFO - Downloaded 10706547 bytes. 02:50:36 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'] 02:50:36 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 02:50:36 INFO - Return code: 0 02:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:36 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:50:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:50:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:50:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 02:50:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:50:40 INFO - Downloaded 111836573 bytes. 02:50:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:50:40 INFO - mkdir: /builds/slave/test/properties 02:50:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:50:40 INFO - Writing to file /builds/slave/test/properties/build_url 02:50:40 INFO - Contents: 02:50:40 INFO - build_url:https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:50:40 INFO - Running post-action listener: _resource_record_post_action 02:50:40 INFO - Running post-action listener: set_extra_try_arguments 02:50:40 INFO - ##### 02:50:40 INFO - ##### Running populate-webroot step. 02:50:40 INFO - ##### 02:50:40 INFO - Running pre-action listener: _resource_record_pre_action 02:50:40 INFO - Running main action method: populate_webroot 02:50:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:50:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:50:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:50:40 INFO - '--tppagecycles', 02:50:40 INFO - '7'], 02:50:40 INFO - 'tests': ['tsvgm']}}, 02:50:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:50:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:50:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:50:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:50:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:50:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:50:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:50:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:40 INFO - 'talos_options': ['--e10s'], 02:50:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:50:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:40 INFO - 'tests': ['damp', 'tps']}, 02:50:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:40 INFO - 'talos_options': ['--e10s'], 02:50:40 INFO - 'tests': ['damp', 'tps']}, 02:50:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:50:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:50:40 INFO - 'other': {'tests': ['a11yr', 02:50:40 INFO - 'ts_paint', 02:50:40 INFO - 'tpaint', 02:50:40 INFO - 'sessionrestore', 02:50:40 INFO - 'sessionrestore_no_auto_restore']}, 02:50:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:50:40 INFO - 'tests': ['a11yr', 02:50:40 INFO - 'ts_paint', 02:50:40 INFO - 'tpaint', 02:50:40 INFO - 'sessionrestore', 02:50:40 INFO - 'sessionrestore_no_auto_restore']}, 02:50:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:50:40 INFO - 'tests': ['a11yr', 02:50:40 INFO - 'ts_paint', 02:50:40 INFO - 'tpaint', 02:50:40 INFO - 'sessionrestore', 02:50:40 INFO - 'sessionrestore_no_auto_restore']}, 02:50:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:50:40 INFO - 'tests': ['a11yr', 02:50:40 INFO - 'ts_paint', 02:50:40 INFO - 'tpaint', 02:50:40 INFO - 'sessionrestore', 02:50:40 INFO - 'sessionrestore_no_auto_restore']}, 02:50:40 INFO - 'other_l64': {'tests': ['a11yr', 02:50:40 INFO - 'ts_paint', 02:50:40 INFO - 'tpaint', 02:50:40 INFO - 'sessionrestore', 02:50:40 INFO - 'sessionrestore_no_auto_restore']}, 02:50:40 INFO - 'other_nol64': {'tests': ['a11yr', 02:50:40 INFO - 'ts_paint', 02:50:40 INFO - 'tpaint', 02:50:40 INFO - 'sessionrestore', 02:50:40 INFO - 'sessionrestore_no_auto_restore']}, 02:50:40 INFO - 'svgr': {'tests': ['tsvgx', 02:50:40 INFO - 'tsvgr_opacity', 02:50:40 INFO - 'tart', 02:50:40 INFO - 'tscrollx', 02:50:40 INFO - 'cart']}, 02:50:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:50:40 INFO - 'tests': ['tsvgx', 02:50:40 INFO - 'tsvgr_opacity', 02:50:40 INFO - 'tart', 02:50:40 INFO - 'tscrollx', 02:50:40 INFO - 'cart']}, 02:50:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:40 INFO - 'tests': ['tp5o']}, 02:50:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:40 INFO - 'talos_options': ['--e10s'], 02:50:40 INFO - 'tests': ['tp5o']}, 02:50:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:40 INFO - 'talos_options': ['--xperf_path', 02:50:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:50:40 INFO - 'tests': ['tp5n']}, 02:50:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:40 INFO - 'talos_options': ['--e10s', 02:50:40 INFO - '--xperf_path', 02:50:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:50:40 INFO - 'tests': ['tp5n']}}, 02:50:40 INFO - 'talos.zip': {'path': '', 02:50:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:50:40 INFO - Running post-action listener: _resource_record_post_action 02:50:40 INFO - ##### 02:50:40 INFO - ##### Running create-virtualenv step. 02:50:40 INFO - ##### 02:50:40 INFO - Running pre-action listener: _resource_record_pre_action 02:50:40 INFO - Running main action method: create_virtualenv 02:50:40 INFO - Creating virtualenv /builds/slave/test/build/venv 02:50:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:50:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:50:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:50:41 INFO - Using real prefix '/tools/python27' 02:50:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:50:41 INFO - Installing distribute.............................................................................................................................................................................................done. 02:50:44 INFO - Installing pip.................done. 02:50:44 INFO - Return code: 0 02:50:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a09ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d3dbd0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f42d30>, '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 0x109d66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f39b20>, '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.Y0wgwYSQiO/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.X1beQl2r6k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:50:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:50:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:50:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y0wgwYSQiO/Render', 02:50:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:50:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:50:44 INFO - 'HOME': '/Users/cltbld', 02:50:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:50:44 INFO - 'LOGNAME': 'cltbld', 02:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:44 INFO - 'MOZ_NO_REMOTE': '1', 02:50:44 INFO - 'NO_EM_RESTART': '1', 02:50:44 INFO - 'PAGER': '/bin/cat', 02:50:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:44 INFO - 'PWD': '/builds/slave/test', 02:50:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:50:44 INFO - 'SHELL': '/bin/bash', 02:50:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1beQl2r6k/Listeners', 02:50:44 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 02:50:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:50:44 INFO - 'USER': 'cltbld', 02:50:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:50:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:44 INFO - 'XPC_FLAGS': '0x0', 02:50:44 INFO - 'XPC_SERVICE_NAME': '0', 02:50:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:50:44 INFO - Cleaning up... 02:50:44 INFO - Return code: 0 02:50:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a09ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d3dbd0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f42d30>, '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 0x109d66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f39b20>, '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.Y0wgwYSQiO/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.X1beQl2r6k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:50:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:50:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:50:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y0wgwYSQiO/Render', 02:50:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:50:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:50:44 INFO - 'HOME': '/Users/cltbld', 02:50:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:50:44 INFO - 'LOGNAME': 'cltbld', 02:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:44 INFO - 'MOZ_NO_REMOTE': '1', 02:50:44 INFO - 'NO_EM_RESTART': '1', 02:50:44 INFO - 'PAGER': '/bin/cat', 02:50:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:44 INFO - 'PWD': '/builds/slave/test', 02:50:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:50:44 INFO - 'SHELL': '/bin/bash', 02:50:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1beQl2r6k/Listeners', 02:50:44 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 02:50:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:50:44 INFO - 'USER': 'cltbld', 02:50:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:50:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:44 INFO - 'XPC_FLAGS': '0x0', 02:50:44 INFO - 'XPC_SERVICE_NAME': '0', 02:50:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:45 INFO - Downloading/unpacking psutil>=0.7.1 02:50: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 02:50: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 02:50: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 02:50: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 02:50: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 02:50: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 02:50:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:50:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:50:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:50:47 INFO - Installing collected packages: psutil 02:50:47 INFO - Running setup.py install for psutil 02:50:48 INFO - building 'psutil._psutil_osx' extension 02:50:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:50:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:50:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:50:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:50:48 INFO - building 'psutil._psutil_posix' extension 02:50:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:50:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:50:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:50:48 INFO - ^ 02:50:48 INFO - 1 warning generated. 02:50:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:50:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:50:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:50:48 INFO - Successfully installed psutil 02:50:48 INFO - Cleaning up... 02:50:48 INFO - Return code: 0 02:50:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a09ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d3dbd0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f42d30>, '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 0x109d66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f39b20>, '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.Y0wgwYSQiO/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.X1beQl2r6k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:50:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:50:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:50:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y0wgwYSQiO/Render', 02:50:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:50:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:50:48 INFO - 'HOME': '/Users/cltbld', 02:50:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:50:48 INFO - 'LOGNAME': 'cltbld', 02:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:48 INFO - 'MOZ_NO_REMOTE': '1', 02:50:48 INFO - 'NO_EM_RESTART': '1', 02:50:48 INFO - 'PAGER': '/bin/cat', 02:50:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:48 INFO - 'PWD': '/builds/slave/test', 02:50:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:50:48 INFO - 'SHELL': '/bin/bash', 02:50:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1beQl2r6k/Listeners', 02:50:48 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 02:50:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:50:48 INFO - 'USER': 'cltbld', 02:50:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:50:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:48 INFO - 'XPC_FLAGS': '0x0', 02:50:48 INFO - 'XPC_SERVICE_NAME': '0', 02:50:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:50: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 02:50: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 02:50: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 02:50: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 02:50: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 02:50: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 02:50:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:50:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:50:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:50:51 INFO - Installing collected packages: mozsystemmonitor 02:50:51 INFO - Running setup.py install for mozsystemmonitor 02:50:51 INFO - Successfully installed mozsystemmonitor 02:50:51 INFO - Cleaning up... 02:50:51 INFO - Return code: 0 02:50:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a09ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d3dbd0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f42d30>, '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 0x109d66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f39b20>, '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.Y0wgwYSQiO/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.X1beQl2r6k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:50:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:50:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:50:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y0wgwYSQiO/Render', 02:50:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:50:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:50:51 INFO - 'HOME': '/Users/cltbld', 02:50:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:50:51 INFO - 'LOGNAME': 'cltbld', 02:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:51 INFO - 'MOZ_NO_REMOTE': '1', 02:50:51 INFO - 'NO_EM_RESTART': '1', 02:50:51 INFO - 'PAGER': '/bin/cat', 02:50:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:51 INFO - 'PWD': '/builds/slave/test', 02:50:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:50:51 INFO - 'SHELL': '/bin/bash', 02:50:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1beQl2r6k/Listeners', 02:50:51 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 02:50:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:50:51 INFO - 'USER': 'cltbld', 02:50:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:50:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:51 INFO - 'XPC_FLAGS': '0x0', 02:50:51 INFO - 'XPC_SERVICE_NAME': '0', 02:50:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:50:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:51 INFO - Downloading/unpacking blobuploader==1.2.4 02:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:54 INFO - Downloading blobuploader-1.2.4.tar.gz 02:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:50:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:50:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:55 INFO - Downloading docopt-0.6.1.tar.gz 02:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:50:55 INFO - Installing collected packages: blobuploader, requests, docopt 02:50:55 INFO - Running setup.py install for blobuploader 02:50:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:50:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:50:55 INFO - Running setup.py install for requests 02:50:55 INFO - Running setup.py install for docopt 02:50:56 INFO - Successfully installed blobuploader requests docopt 02:50:56 INFO - Cleaning up... 02:50:56 INFO - Return code: 0 02:50:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:50: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')]} 02:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50: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')]} 02:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:56 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 0x10a09ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d3dbd0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f42d30>, '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 0x109d66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f39b20>, '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.Y0wgwYSQiO/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.X1beQl2r6k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:50:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:50:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:50:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y0wgwYSQiO/Render', 02:50:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:50:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:50:56 INFO - 'HOME': '/Users/cltbld', 02:50:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:50:56 INFO - 'LOGNAME': 'cltbld', 02:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:56 INFO - 'MOZ_NO_REMOTE': '1', 02:50:56 INFO - 'NO_EM_RESTART': '1', 02:50:56 INFO - 'PAGER': '/bin/cat', 02:50:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:56 INFO - 'PWD': '/builds/slave/test', 02:50:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:50:56 INFO - 'SHELL': '/bin/bash', 02:50:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1beQl2r6k/Listeners', 02:50:56 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 02:50:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:50:56 INFO - 'USER': 'cltbld', 02:50:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:50:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:56 INFO - 'XPC_FLAGS': '0x0', 02:50:56 INFO - 'XPC_SERVICE_NAME': '0', 02:50:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:50:56 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-8d3BTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:50:56 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-sbkpPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:50:56 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-Tscaus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:50:56 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-9FiFdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:50:56 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-KH5_cQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:50:56 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-e7eQ88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:50:57 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-zy4UiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:50:57 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-18lPFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:50:57 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-XraeqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:50:57 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-tHfLXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:50:57 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-M_O_d9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:50:57 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-KVVR4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:50:57 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-Qbv9bD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:50:57 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-i3D9dO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:50:57 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-idbhx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:50:58 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-8L_8S1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:50:58 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-oh344y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:50:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:50:58 INFO - Running setup.py install for manifestparser 02:50:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:50:58 INFO - Running setup.py install for mozcrash 02:50:58 INFO - Running setup.py install for mozdebug 02:50:58 INFO - Running setup.py install for mozdevice 02:50:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:50:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:50:58 INFO - Running setup.py install for mozfile 02:50:58 INFO - Running setup.py install for mozhttpd 02:50:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:50:59 INFO - Running setup.py install for mozinfo 02:50:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:50:59 INFO - Running setup.py install for mozInstall 02:50:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:50:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:50:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:50:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:50:59 INFO - Running setup.py install for mozleak 02:50:59 INFO - Running setup.py install for mozlog 02:50:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:50:59 INFO - Running setup.py install for moznetwork 02:50:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:50:59 INFO - Running setup.py install for mozprocess 02:50:59 INFO - Running setup.py install for mozprofile 02:51:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:51:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:51:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:51:00 INFO - Running setup.py install for mozrunner 02:51:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:51:00 INFO - Running setup.py install for mozscreenshot 02:51:00 INFO - Running setup.py install for moztest 02:51:00 INFO - Running setup.py install for mozversion 02:51:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:51:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:51:00 INFO - Cleaning up... 02:51:00 INFO - Return code: 0 02:51:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a09ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d3dbd0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f42d30>, '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 0x109d66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f39b20>, '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.Y0wgwYSQiO/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.X1beQl2r6k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:51:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:51:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:51:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y0wgwYSQiO/Render', 02:51:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:00 INFO - 'HOME': '/Users/cltbld', 02:51:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:00 INFO - 'LOGNAME': 'cltbld', 02:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:00 INFO - 'MOZ_NO_REMOTE': '1', 02:51:00 INFO - 'NO_EM_RESTART': '1', 02:51:00 INFO - 'PAGER': '/bin/cat', 02:51:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:00 INFO - 'PWD': '/builds/slave/test', 02:51:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:00 INFO - 'SHELL': '/bin/bash', 02:51:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1beQl2r6k/Listeners', 02:51:00 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 02:51:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:00 INFO - 'USER': 'cltbld', 02:51:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:00 INFO - 'XPC_FLAGS': '0x0', 02:51:00 INFO - 'XPC_SERVICE_NAME': '0', 02:51:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:51:01 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-aS9Yc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:51:01 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-mWigRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:51:01 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)) 02:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:51:01 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-HZwW9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:51:01 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-Q2oTLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:51:01 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-czenBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:51:01 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-Mv2V_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:51:01 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-cE1Xgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:51:01 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-CRTfe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:51:01 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-8X4qN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:51:02 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-PTU02U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:51:02 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-2c96q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:51:02 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-kqGINK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:51:02 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-FjD6sC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:51:02 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-eDOZdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:02 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-Q7Hsv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:51:02 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-xyJCpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:51:02 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-9_UVuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:51:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:05 INFO - Downloading blessings-1.6.tar.gz 02:51:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:51:05 INFO - Installing collected packages: blessings 02:51:05 INFO - Running setup.py install for blessings 02:51:05 INFO - Successfully installed blessings 02:51:05 INFO - Cleaning up... 02:51:05 INFO - Return code: 0 02:51:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:51:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:51:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:51:05 INFO - Reading from file tmpfile_stdout 02:51:05 INFO - Current package versions: 02:51:05 INFO - blessings == 1.6 02:51:05 INFO - blobuploader == 1.2.4 02:51:05 INFO - docopt == 0.6.1 02:51:05 INFO - manifestparser == 1.1 02:51:05 INFO - mozInstall == 1.12 02:51:05 INFO - mozcrash == 0.16 02:51:05 INFO - mozdebug == 0.1 02:51:05 INFO - mozdevice == 0.48 02:51:05 INFO - mozfile == 1.2 02:51:05 INFO - mozhttpd == 0.7 02:51:05 INFO - mozinfo == 0.9 02:51:05 INFO - mozleak == 0.1 02:51:05 INFO - mozlog == 3.1 02:51:05 INFO - moznetwork == 0.27 02:51:05 INFO - mozprocess == 0.22 02:51:05 INFO - mozprofile == 0.28 02:51:05 INFO - mozrunner == 6.11 02:51:05 INFO - mozscreenshot == 0.1 02:51:05 INFO - mozsystemmonitor == 0.0 02:51:05 INFO - moztest == 0.7 02:51:05 INFO - mozversion == 1.4 02:51:05 INFO - psutil == 3.1.1 02:51:05 INFO - requests == 1.2.3 02:51:05 INFO - wsgiref == 0.1.2 02:51:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a09ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d3dbd0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f42d30>, '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 0x109d66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f39b20>, '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.Y0wgwYSQiO/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.X1beQl2r6k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:51:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:51:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:51:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y0wgwYSQiO/Render', 02:51:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:05 INFO - 'HOME': '/Users/cltbld', 02:51:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:05 INFO - 'LOGNAME': 'cltbld', 02:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:05 INFO - 'MOZ_NO_REMOTE': '1', 02:51:05 INFO - 'NO_EM_RESTART': '1', 02:51:05 INFO - 'PAGER': '/bin/cat', 02:51:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:05 INFO - 'PWD': '/builds/slave/test', 02:51:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:05 INFO - 'SHELL': '/bin/bash', 02:51:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1beQl2r6k/Listeners', 02:51:05 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 02:51:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:05 INFO - 'USER': 'cltbld', 02:51:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:05 INFO - 'XPC_FLAGS': '0x0', 02:51:05 INFO - 'XPC_SERVICE_NAME': '0', 02:51:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:51:06 INFO - Cleaning up... 02:51:06 INFO - Return code: 0 02:51:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:06 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 0x10a09ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d3dbd0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f42d30>, '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 0x109d66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f39b20>, '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.Y0wgwYSQiO/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.X1beQl2r6k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:51:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:51:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:51:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y0wgwYSQiO/Render', 02:51:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:06 INFO - 'HOME': '/Users/cltbld', 02:51:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:06 INFO - 'LOGNAME': 'cltbld', 02:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:06 INFO - 'MOZ_NO_REMOTE': '1', 02:51:06 INFO - 'NO_EM_RESTART': '1', 02:51:06 INFO - 'PAGER': '/bin/cat', 02:51:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:06 INFO - 'PWD': '/builds/slave/test', 02:51:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:06 INFO - 'SHELL': '/bin/bash', 02:51:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1beQl2r6k/Listeners', 02:51:06 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 02:51:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:06 INFO - 'USER': 'cltbld', 02:51:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:06 INFO - 'XPC_FLAGS': '0x0', 02:51:06 INFO - 'XPC_SERVICE_NAME': '0', 02:51:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:06 INFO - Downloading/unpacking jsonschema 02:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:51:08 INFO - Downloading/unpacking functools32 (from jsonschema) 02:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:08 INFO - Downloading functools32-3.2.3-2.tar.gz 02:51:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:51:09 INFO - warning: no files found matching '*.txt' 02:51:09 INFO - no previously-included directories found matching 'build' 02:51:09 INFO - no previously-included directories found matching 'dist' 02:51:09 INFO - no previously-included directories found matching '.git*' 02:51:09 INFO - Installing collected packages: jsonschema, functools32 02:51:09 INFO - Running setup.py install for functools32 02:51:09 INFO - warning: no files found matching '*.txt' 02:51:09 INFO - no previously-included directories found matching 'build' 02:51:09 INFO - no previously-included directories found matching 'dist' 02:51:09 INFO - no previously-included directories found matching '.git*' 02:51:09 INFO - Successfully installed jsonschema functools32 02:51:09 INFO - Cleaning up... 02:51:09 INFO - Return code: 0 02:51:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a09ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d3dbd0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f42d30>, '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 0x109d66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f39b20>, '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.Y0wgwYSQiO/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.X1beQl2r6k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:51:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:51:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y0wgwYSQiO/Render', 02:51:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:09 INFO - 'HOME': '/Users/cltbld', 02:51:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:09 INFO - 'LOGNAME': 'cltbld', 02:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:09 INFO - 'MOZ_NO_REMOTE': '1', 02:51:09 INFO - 'NO_EM_RESTART': '1', 02:51:09 INFO - 'PAGER': '/bin/cat', 02:51:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:09 INFO - 'PWD': '/builds/slave/test', 02:51:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:09 INFO - 'SHELL': '/bin/bash', 02:51:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1beQl2r6k/Listeners', 02:51:09 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 02:51:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:09 INFO - 'USER': 'cltbld', 02:51:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:09 INFO - 'XPC_FLAGS': '0x0', 02:51:09 INFO - 'XPC_SERVICE_NAME': '0', 02:51:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:09 INFO - Downloading/unpacking flake8 02:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:51:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:51:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:51:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:51:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:51:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:51:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:51:13 INFO - no previously-included directories found matching 'docs/_build' 02:51:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:51:13 INFO - Running setup.py install for pep8 02:51:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:51:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:51:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:51:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:51:13 INFO - no previously-included directories found matching 'docs/_build' 02:51:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:51:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:51:13 INFO - Cleaning up... 02:51:13 INFO - Return code: 0 02:51:13 INFO - Running post-action listener: _resource_record_post_action 02:51:13 INFO - Running post-action listener: _start_resource_monitoring 02:51:13 INFO - Starting resource monitoring. 02:51:13 INFO - ##### 02:51:13 INFO - ##### Running install step. 02:51:13 INFO - ##### 02:51:13 INFO - Running pre-action listener: _resource_record_pre_action 02:51:13 INFO - Running main action method: install 02:51:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:51:13 INFO - Reading from file tmpfile_stdout 02:51:13 INFO - Detecting whether we're running mozinstall >=1.0... 02:51:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:51:13 INFO - Reading from file tmpfile_stdout 02:51:13 INFO - Output received: 02:51:13 INFO - Usage: mozinstall [options] installer 02:51:13 INFO - Options: 02:51:13 INFO - -h, --help show this help message and exit 02:51:13 INFO - -d DEST, --destination=DEST 02:51:13 INFO - Directory to install application into. [default: 02:51:13 INFO - "/builds/slave/test"] 02:51:13 INFO - --app=APP Application being installed. [default: firefox] 02:51:13 INFO - mkdir: /builds/slave/test/build/application 02:51:13 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'] 02:51:13 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 02:51:47 INFO - Reading from file tmpfile_stdout 02:51:47 INFO - Output received: 02:51:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:51:47 INFO - Running post-action listener: _resource_record_post_action 02:51:47 INFO - ##### 02:51:47 INFO - ##### Running run-tests step. 02:51:47 INFO - ##### 02:51:47 INFO - Running pre-action listener: _resource_record_pre_action 02:51:47 INFO - Running main action method: run_tests 02:51:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:51:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:51:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:51:47 INFO - 2016-02-10 02:51:47.809 screenresolution[2089:13303] starting screenresolution argv=screenresolution get 02:51:47 INFO - 2016-02-10 02:51:47.812 screenresolution[2089:13303] Display 0: 1600x1200x32@60 02:51:47 INFO - 2016-02-10 02:51:47.818 screenresolution[2090:13305] starting screenresolution argv=screenresolution list 02:51:47 INFO - Available Modes on Display 0 02:51:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:51:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:51:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:51:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:51:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:51:48 INFO - Intel Iris: 02:51:48 INFO - Chipset Model: Intel Iris 02:51:48 INFO - Type: GPU 02:51:48 INFO - Bus: Built-In 02:51:48 INFO - VRAM (Dynamic, Max): 1536 MB 02:51:48 INFO - Vendor: Intel (0x8086) 02:51:48 INFO - Device ID: 0x0a2e 02:51:48 INFO - Revision ID: 0x0009 02:51:48 INFO - Displays: 02:51:48 INFO - Display: 02:51:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:51:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:51:48 INFO - Display Serial Number: 1600x1200 60 02:51:48 INFO - Main Display: Yes 02:51:48 INFO - Mirror: Off 02:51:48 INFO - Online: Yes 02:51:48 INFO - Rotation: Supported 02:51:48 INFO - Return code: 0 02:51:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:51:48 INFO - Python 2.7.3 02:51:48 INFO - Return code: 0 02:51:48 INFO - grabbing minidump binary from tooltool 02:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:48 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 0x109f42d30>, '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 0x109d66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f39b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:51:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:51:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:51:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:51:48 INFO - Return code: 0 02:51:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:51:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:51:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:51:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:51:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:51:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:51:49 INFO - Return code: 0 02:51:49 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/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0096', '--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 02:51:49 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/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0096 --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 02:51:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y0wgwYSQiO/Render', 02:51:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:49 INFO - 'HOME': '/Users/cltbld', 02:51:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:49 INFO - 'LOGNAME': 'cltbld', 02:51:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:51:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:49 INFO - 'MOZ_NO_REMOTE': '1', 02:51:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:51:49 INFO - 'NO_EM_RESTART': '1', 02:51:49 INFO - 'PAGER': '/bin/cat', 02:51:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:49 INFO - 'PWD': '/builds/slave/test', 02:51:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:51:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:49 INFO - 'SHELL': '/bin/bash', 02:51:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1beQl2r6k/Listeners', 02:51:49 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 02:51:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:49 INFO - 'USER': 'cltbld', 02:51:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:49 INFO - 'XPC_FLAGS': '0x0', 02:51:49 INFO - 'XPC_SERVICE_NAME': '0', 02:51:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:49 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/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0096', '--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 02:51:49 INFO - mozversion application_buildid: 20160208164823 02:51:49 INFO - mozversion application_changeset: 49945e5fe79e6cf2b083f56fd49d917ca886db0b 02:51:49 INFO - mozversion application_display_name: Nightly 02:51:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:51:49 INFO - mozversion application_name: Firefox 02:51:49 INFO - mozversion application_remotingname: firefox 02:51:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:51:49 INFO - mozversion application_vendor: Mozilla 02:51:49 INFO - mozversion application_version: 47.0a1 02:51:49 INFO - mozversion platform_buildid: 20160208164823 02:51:49 INFO - mozversion platform_changeset: 49945e5fe79e6cf2b083f56fd49d917ca886db0b 02:51:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:51:49 INFO - mozversion platform_version: 47.0a1 02:51:49 INFO - using testdate: 1455101509 02:51:49 INFO - actual date: 1455101509 02:51:49 INFO - starting webserver on 'localhost:49374' 02:51:49 INFO - SUITE-START | Running 2 tests 02:51:49 INFO - TEST-START | dromaeo_css 02:51:49 INFO - operating with platform_type : mac_ 02:51:49 INFO - Initialising browser for dromaeo_css test... 02:51:49 INFO - TEST-INFO | started process 2108 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpSIu4ma/profile http://localhost:49374/getInfo.html) 02:51:52 INFO - PROCESS | 2108 | __metrics Screen width/height:1600/1200 02:51:52 INFO - PROCESS | 2108 | colorDepth:24 02:51:52 INFO - PROCESS | 2108 | Browser inner width/height: 1024/689 02:51:52 INFO - PROCESS | 2108 | __metrics 02:51:52 INFO - PROCESS | 2108 | 02:51:52 INFO - PROCESS | 2108 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 02:51:52 INFO - PROCESS | 2108 | 02:51:53 INFO - TEST-INFO | 2108: exit 0 02:51:53 INFO - Browser initialized. 02:51:53 INFO - Running cycle 1/1 for dromaeo_css test... 02:51:53 INFO - TEST-INFO | started process 2113 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpSIu4ma/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:52:05 INFO - PROCESS | 2113 | RSS: Main: 258482176 02:52:05 INFO - PROCESS | 2113 | 02:52:55 INFO - PROCESS | 2113 | 1455101575270 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] 02:55:05 INFO - PROCESS | 2113 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49374/tests/dromaeo/cssquery-ext.html) 02:55:06 INFO - PROCESS | 2113 | RSS: Main: 270614528 02:55:06 INFO - PROCESS | 2113 | 02:58:08 INFO - PROCESS | 2113 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-ext.html (next: http://localhost:49374/tests/dromaeo/cssquery-jquery.html) 02:58:09 INFO - PROCESS | 2113 | RSS: Main: 283021312 02:58:09 INFO - PROCESS | 2113 | 03:01:10 INFO - PROCESS | 2113 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49374/tests/dromaeo/cssquery-mootools.html) 03:01:11 INFO - PROCESS | 2113 | RSS: Main: 284372992 03:01:11 INFO - PROCESS | 2113 | 03:04:13 INFO - PROCESS | 2113 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49374/tests/dromaeo/cssquery-prototype.html) 03:04:13 INFO - PROCESS | 2113 | RSS: Main: 286740480 03:04:13 INFO - PROCESS | 2113 | 03:07:16 INFO - PROCESS | 2113 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49374/tests/dromaeo/cssquery-yui.html) 03:07:16 INFO - PROCESS | 2113 | RSS: Main: 290222080 03:07:16 INFO - PROCESS | 2113 | 03:10:19 INFO - PROCESS | 2113 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-yui.html (next: http://localhost:49374/tests/dromaeo/cssquery-dojo.html) 03:10:19 INFO - PROCESS | 2113 | RSS: Main: 291639296 03:10:19 INFO - PROCESS | 2113 | 03:10:19 INFO - PROCESS | 2113 | __start_tp_report 03:10:19 INFO - PROCESS | 2113 | _x_x_mozilla_page_load 03:10:19 INFO - PROCESS | 2113 | _x_x_mozilla_page_load_details 03:10:19 INFO - PROCESS | 2113 | |i|pagename|runs| 03:10:19 INFO - PROCESS | 2113 | |0;dojo.html;3280.8031518108914;3489.6510348965107;3521.9647803521975;3523.207278362369;3524.136586536299;4701.435827700677;5669.858253543658;5698.401667824881;5735.827925162242;5750.712464376786;5502.58730595205;5560.4161563035905;5714.628549144302;5737.397573254801;5939.85150371241;5115.411727651312;5167.844964651066;5177.715225662587;5196.688198708071;5237.685738855662;527.40330499025;5203.60972927032;5227.32044834171;5232.947670523303;5235.633505654606;4371.562843715635;4735.721355234102;5140.3831540215415;5178.48215178481;5194.480551944813;5101.20931255656;5210.53105220532;5213.973930130363;5221.112410890158;5229.137192363255;5037.622178336639;5092.516210959953;5150.819721309774;5170.715610641413;5198.090334191501;5518.2826232589905;5598.608097433182;5666.376698563155;5715.057015592422;5723.370429252779;6072.2713274406915;6133.3559976202305;6223.097650840648;6226.533010024266;6230.470410015108;6257.280412752546;6272.686365681698;6280.528960327948;6287.779927702509;6313.179286692746;5800.506956908668;5801.88396232073;5818.2436283282905;5842.766289348421;5854.063349864044;5519.475649813261;6160.507159427235;6190.164327815687;6263.185785847902;6284.214473190851;5926.288845338587;6125.1731016313115;6139.631622102688;6156.476699480505;6158.353372895782;6099.695015249308;6242.2509298883515;6258.718357673915;6272.937270627326;6280.309165991737;6164.4760195383;6172.660503672341;6180.165677633552;6210.099535567318;6221.09794079865;6191.071339299141;6224.937750622526;6229.127922090911;6230.190075290183;6289.842753931189;4759.190937540627;4853.490383509751;4879.877628145476;4932.53140951609;4965.776540055634;3725.8137093145233;4356.215881141425;4392.846250381222;4398.824047038147;4404.823807047682;5456.945430545723;5698.515626171822;5720.496367978412;5763.452472015152;5781.682007489544;5132.409772876167;5589.972050139804;6219.626822390671;6258.311585725566;6306.873862522724;5698.202251684685;5726.828195154152;5735.827925162252;5740.368559458456;5762.827115186551;5246.63273570854;5331.253624492574;5360.410354860962;5449.427810079964;5470.91793623096;6248.562600617913;6249.937500625027;6268.4671802896355;6277.96861015692;6302.401271879165;6138.324784273816;6143.501336845131;6183.103449999815;6186.566940314135;6205.596636218631;6125.05232106189;6196.1635179250225;6239.001759718423;6243.219597550306;6253.96873015632;6161.291451483136;6163.445289923929;6170.6914654268;6175.104609831459;6193.473554747897;6119.082137679384;6135.04893764628;6197.194364732556;6206.906896396648;6246.906296405648;5995.100734889627;6020.51835853122;6099.340048627855;6130.172426722514;6144.877102457836;6039.063945088518;6054.788082417094;6080;6088.238970128734;6124.510039196943;5873.3832947541605;5892.734826932884;5948.643081415129;6006.069059295816;6055.031195008954;5378.515933565998;6092.603980741238;6096.542759292982;6099.359567245376;6119.990201616683;5902.675352855634;5970.373110823301;5971.954907891189;5977.671228082497;5982.760689572368 03:10:19 INFO - PROCESS | 2113 | |1;ext.html;445.77933922708246;464.6097278286239;524.4205153305599;565.6351653183697;588.4527389527743;33022.50466243005;37325.62674373255;37361.25277494452;37448.62551374489;37521;38565.42151867724;39077.609223907755;39089.21821563567;39123.60876391242;39333;9358.53207339632;9507.762305942337;9535.952320238424;9593.184579310768;9619.519024048805;9412.34113612044;9681.854772178423;9716;9723;9742.659006934759;9673.37123086997;9776.413415195075;9786.461744604045;9800.31397802154;9802.803943921117;9638.228941684683;9671.806563868684;9725.951370243103;9741.707748767549;9797.118259356692;9518.333716639838;9633.470159141245;9654.082862128087;9678.467684277362;9691.66079187232;37127.62872371269;37366.62633373686;37519.437208441894;37645.81177094097;37810.81094594509;2813.2826129336886;2875.223689603816;3327.5341452196712;3406.7274618030747;3432.8970130896114;26753.598696019577;27050.323741906413;27270.04554840591;27690.169294921183;28057.87768489258;2741.821781584191;2745.08039806665;2793.2318612381555;2913.2716820794803;2945.587617733519;348113;349501;350534;351676;476526;57190.42809571934;62663.373366266664;63598.36401636017;63731;63829;58329;61497.69251153805;61752.38247617556;61877;61905.38094618996;15709.743220542328;15793.526194213962;15923.363065477482;16096.71226301893;16098.919505402398;12145.757084858253;12285.69285767845;12325.50697972071;12372;12580.496780128693;19482.4155275342;19527.414177574694;19691.507712307306;19698.60602787965;19759.60480790405;8553.14468553152;8657.008887955679;8733.91266087331;8775.297976161892;8785.692500762443;903.2548147777978;916.1022198245756;1063.7606538528769;1090.5647211284518;1161.6747310753003;23924.05441174989;28969.275768105545;29313.267168320963;29721.55417668737;29780.40439191204;1028.8733836449076;1084.8806631270554;1110.566878917223;1142.765733024728;1183.8875306845837;12978.805317920238;14887.404503819726;14953.775693364609;15032.323545440482;15148.242587870562;425054;523049;524142.3792881087;525347;526036;55800.16299755507;56115.71942140263;56200.15699764507;56461.71769141128;56496.15255771167;1417.730631180093;1433.7777644465125;1441.3657990484153;1442.314900422291;1536.9779096900436;25293.367665808502;28711;28885.844566217114;29466.968656096935;29640.55539166871;49455.50544494509;49559.504404955485;49973.25040124474;50024.49975500198;50113.498865010886;475759;477764;478308;480657;480991;32019.839900800347;32876.835615821765;32913.01260962175;32960.67039329576;32964.67035329616;41090.79454602708;42738.78630606827;43232.91917702083;43348.13303733971;43434.19733567393;34154.658453416145;34863.47704784481;35016.299674005866;36016;36541.634583653824;35006.12484687903;35277;35418.468722969694;35450.82274588611;35597.82201088978;35143.824280878434;35338;35570.822145889106;35626.28747424985;35691.46462803008;26315.921032240032;31678.524822128147;31873.269302731696;31992.52011219787;32020.19949501281;24115.744374509217;24280.75719242785;24349;24528.264152075466;24750.38124046913 03:10:19 INFO - PROCESS | 2113 | |2;jquery.html;352.07053379079235;356.08663777410936;358.9389803733365;360.4971065363819;360.8466401779245;15256.69486610267;18346.449606511793;19255.326063587778;19320.51698707533;20341.982900854953;11652.708682282926;18370.540736481562;18547.443576692687;19057.90471047646;19083.236670533195;5365.436629153941;5523.6409633373905;5525.751341189656;5527.364353099385;5558.249636299089;4673.813047478096;5162.92255616166;5421.972890135544;5437.891242175154;5445.401005889349;3969.6625786808154;5412.9458705412835;5424.484673955988;5429.158480435519;5832.008558545058;5976.133460648225;6015.157877897098;6051.12258722485;6067.241594800672;6100.72546735398;5664.773409063632;5697.4587414195585;5700.486956173964;5760.876629057336;5766.596338256324;13293.667658308523;19417.708734368996;23513.764862351327;24181.516369672507;24464.77676116187;2142.232658057109;2203.746569144537;2228.5320082782637;2265.4109931417784;2630.395009147888;9709.271804614682;9886.159676427513;10273;10307.742306442324;10355.068043876012;1537.2083377060824;1544.524819156897;1790.6776780179562;1812.6918423867974;1818.5180927054341;95899.52050239773;98993;99152;100329.99340013159;100555.49722251343;11049.33703977764;11244.943775281072;11351.716207094889;11377.431128443544;11474.196806223485;12518.937405313098;13040.934795325962;13155;13462.932685336511;13534.323283835769;6963.79108626742;8096.595170241464;8261.917380826235;8284.875726864102;8342.499450033018;8434.734789781582;8483.490990540464;8505.277051450696;8515.19105684959;8517.48895066298;4357.455318085239;4369.366441865912;4373.606375426227;4378.365137055109;4442.200403927324;1688.1093175643357;1837.2283640870867;1893.2710906301172;1897.8576606754548;1933.622943526027;759.7606753872512;885.3315746611396;889.3552174673439;903.584351198456;993.7714325705128;13003.414846331938;15203.771943420857;17756.023418711837;19069.809301906804;19113.904430478036;912.4069354919355;920.5305294299822;943.5942544705842;943.6744323208482;944.5843828715343;10224.897751022543;10270.07569318765;10368;10603.363798172135;10820.458977051116;735810;742020;744131;755606;766194;89368.5531572338;105591.94408055974;108615.45692271487;120773.18840217404;122284.38857805655;1117.1844553476008;1163.5752950173126;1163.7323415614455;1168.9590864319707;1172.6247600767672;15042.323095460511;18037.458876233733;18089.728654070463;18346.08269586542;18497.81502184961;47628;48961.77595560139;49532.25701614551;49607.75196123996;50315.49684503255;54319;62160;65500;67044.32955670381;71518.64240678764;7544.245575442412;7691.4615976883315;7703.345215656732;7779.57212353326;7787.338076263581;10663;10668.706228160983;10697.411642359744;11597.710057248636;11758.118141139277;9977.251706121924;10017.499125043865;10260.692179234635;10601.840972385575;10637.521311541153;8265.628046737791;9868.605255789687;9884.703458896245;10139.543720532742;10620.415877126523;10118.08937195656;10193.694189174337;10406.323588966692;10783.137349011904;10792;6665.233498147775;7339.77980660581;7482.588457634664;7592.316691497571;7656.885146722915;8079.555624440713;10516.57933682644;10583;10594.31136976125;10597.682069537927 03:10:19 INFO - PROCESS | 2113 | |3;mootools.html;1504.8946573739836;1535.8804849307958;1735.2625134317911;1855.8144185581434;1875.2780179630838;7373.9307800368915;7930.96034519828;8691.043985161636;8761.167689069536;8911.376203665746;8313.792155196123;8590.871136932936;8743.387962842604;8750.737477875658;8753.737387878375;2435.9634605480933;2448.5837407640697;2477.5664258754737;2481.6525686403916;2496.163785131983;2431.963520547193;2474.938126546842;2487.1543675150447;2491.576432006563;2492.190038237571;2188.4966457714736;2401.0635852017726;2452.491717593685;2459.090136649433;2475.356407334088;2107.546877421362;2396.664466974625;2406.554787364343;2439.134107391877;2452.730199678034;2438.5244877248942;2450.509898020385;2453.411181316489;2459.3605662527693;2469.3949982254285;8632.741017769476;8641.913580864237;8707.25988290996;8718.084601116854;8735.126487351214;5347.385050719178;5434.728263586805;5486.204500347467;5508.366537848158;5527.613067085305;3294.89620976973;3515;3678.503402040717;3737.6636102750613;3755.4930084438524;1053.857729206555;1072.3726619927352;1078.757279612089;1105.8341248812742;1106.9059129973962;11875.52497900083;11877.049836013099;11929.224600400947;12033.6389908302;12069.879301206964;4853.927191092136;4895.951040489621;4925.679830811057;4985.052839960396;5010.473900240495;9984.600615975425;10045.598176072876;10188.796224075477;10207.846882296772;10220.233482488844;5388.164834450667;5404.540614047772;5466.808661696821;5482.506574408322;5490.780368785284;4858.951410485921;4934.7285899275885;4949.802007919643;4970.8757281068265;4988.9501104988485;3926.2736393767245;3964.940525892114;3978.7214894957656;3999.1201935574127;4014.8193331300163;1080.4597701149426;1304.6281809684194;1330.8602596727205;1332.9133606315559;1341.7718987771907;956.6699488676395;1078.8813230544633;1086.3699054548342;1177.364223319398;1317.914335568185;7893.526388416713;7895.328897043701;7928.484648497829;7989.041315042232;8264.173582641808;1174.3482367286238;1180.893719565226;1198.9700257493457;1206.4209179593845;1208.8005479096028;6270.467010304175;6285.96857015712;6319.557630965788;6324.525660575475;6347.016212487072;10431.530581123867;10622.203334749925;10753.51609177589;10794.190435717195;10912.526808880859;10445.895541044645;10646.041856232976;10671.35971841692;10734.033936945556;10765.623203187852;8238.711645092393;8322.45904016237;8424.915750842536;8491.660333586711;8520.8721869172;7897.131315555399;7934.444588878723;7978.800529986796;8007.999000124984;8008.319292860172;9250.491222982531;9535.38020028696;9634.13292803651;9742.561584728563;9835.016498350107;9168.266538677024;9718.9028109718;9768.609255629979;9833;9912.00879912003;7385.483016188815;7459.067616547932;7514;7534.434917381109;7556.508826926232;8010.359171266401;8017.238362355567;8055.476394034369;8096;8106.229908158715;7058.576485410892;7638.50349727266;7679.897707917977;7721.691132354643;7804.8829267559895;5939.821805345847;7370.705171793068;7420.591867447342;7490.812729681802;7505.774826755206;6807.3873351398615;7349.713800085071;7635.465517413728;7708.807279818049;7717.691292348468;6826.556273842184;6900.999355093383;6906.274841141608;6951.9304806953305;6970.756023539152;7026.332498412643;7093.858122837618;7173.713051478091;7198.5320954137815;7205.927940720526 03:10:19 INFO - PROCESS | 2113 | |4;prototype.html;322.7901863788538;328.65819547670424;332.47966931751824;335.65427609562147;337.5021842781897;5567.4432556744305;6542.887709089454;6771.255161932184;6843.589384636925;6901.30986901309;4796.856094317176;5258.921921006194;5962.522998160148;6719.596824190552;6774.288699686524;4366.4978527469275;4973.01079568172;5068.898622027557;5094.745262736848;5097.898042039157;5092.872678183038;5097.974510127444;5100.234964755279;5104.3619547556555;5119.667221630601;4728.739919304437;4887.584555312803;4895.143349913768;4899.51004899509;4912.091263116317;4456.930336719196;4578.496365399803;4876.804927802884;4884.633652476043;4886.60907127429;4159;4177.540470548268;4178.331466965271;4178.456800615931;4187.392828039948;6368.681565921732;6588.8023359299295;6594.835129121762;6627.569208001512;6655.600663960178;5066.898662026776;5841.678707671076;5855.209546711225;5863.560232982543;5870.148828419898;5926.348101708809;7280.599567023812;7282.162551306615;7294.161171465296;7332.78001659951;3855.6722678572073;4663.510331415187;4669.836555720567;4676.205045142334;4680.485146633868;7463.813404664873;7678.616069196573;7806.765797026098;7809.2190780921455;7822.882656760153;4673.392458980379;4714.95285047152;4722.173619616622;4732.787024583902;4754.453237877619;4188.099558594856;4794.304825800309;4809.951900480951;4810.5670489656095;4830.637702172351;4873.488283730228;5485.50630443262;5795.9277533656405;5796.5072968797285;5801.3328467225965;6323.588966717149;6974.465617564128;7313.195548489662;7328.67020984057;7329.853402931912;1571.2615070916652;1629.8451647093507;1671.8746094042995;1674.1880188108757;1676.1451659653665;1033.994830025845;1051.8790339111101;1064.2071656615872;1068.316277582348;1069.4706120470416;5468.890622187534;5648.209250704905;6072.696365181811;6176.320604733476;6726.293739157416;7597.848043039219;7611.923880761122;7613.581253031137;7616.504927179715;7650.349720273728;5566.972165139148;6400.9039864402075;6629.141347029585;6710.664466776641;6791.830204244933;4009.578994205625;4032.354823228269;4044.6359827615656;4045.7774822384463;4048.0891799344913;7907;7910.485818421784;7932.484388514844;7933.484323518953;7980.241877021674;7509.774706758806;7815.179406162385;7815.491993020435;7819.960900195462;7870.780029095499;7881;7897.802554936173;7903.407244456574;7913.208679132041;7918.129005809356;6643.734250629921;7247.311505406978;7557.395408367208;7599.88600171009;7621.809454763676;6884.311568843075;7085.964570177116;7177.4616903731385;7464.141623713125;7484.064491938508;6394.328595497405;7867.095284042409;7867.488613240121;7889.921100788919;7902.841943161219;4737.478877323423;4745.928811067768;4748.833790817304;4760.309755085424;4776.641751868554;7314.268573142643;7385.261473852786;7531.133919599316;7652.38780897538;7662.73180438682;7339.6330183489545;7412.814679633052;7423.888641670272;7425.257474252531;7490.475666703279;6189.76204759059;7428.33145016951;7440.627968601657;7443.739469118555;7457.552546847207;6938.202106757787;7241.746538871114;7261.6006119661815;7265.20082790882;7271.163816160997;6096.908546371719;7400.333969942731;7408.370288525536;7424.294692004251;7438.404927605887;7043.36609705129;7215.458840587082;7252.383547398319;7255.383292419992;7292.453066019963 03:10:19 INFO - PROCESS | 2113 | |5;yui.html;660.5805313625848;694.3507820188124;723.7286017743346;725.4196642685852;734.9338559529641;14529.273536323168;14685.265736713149;14688.41246350146;14732.410703571857;14820.777688334683;13509.555063458803;13921.37353819078;14047.508337208199;14048.859511404882;14070.57788266351;677.2347247610194;832.3840358134981;839.5802098950525;848.5672307123381;864.2481041493909;852.4075767341669;863.7365603490932;864.0883867519764;864.356054739217;866.9913300867005;902.4044130873625;903.503073309677;904.7466709321368;906.5331354352513;909.3316412436886;893.2809088683607;894.9328800339968;895.042304733935;895.8342706599267;896.8699538566937;666.4135560706595;666.7066490744057;666.7066490744105;667.302668711198;669.0967194287673;14250.358733857001;14440.927795361062;14558.4904528341;14615.269236538237;14645.853541464556;12622.305773182472;12670.619881403572;12739.171953822972;12972.675683107998;12985;8713.825723485495;9942.403455792602;10318.948405258001;10332.79334413315;10376.896231037668;3549.4498352755363;3578.964210357889;3584.551931008624;3592.119930616989;3606.8376923038527;80258;80264.19735802626;80488.59755701185;82225.58887205645;82637.58681206616;9379.765505862271;9410.858837117448;9596.335926400616;9683.225341972626;10018.899811001942;18408.53978650518;19158;20438.875861827444;20604.587908241752;20671.276505322243;7447.441441891771;7595.240475952471;7606;7691.1924247954275;7962.960185199037;3517.43721004638;4095.672346212296;4128.091819799639;4137.855175068858;4157.8960525987095;3513.9648603513638;3544.5923718772156;3547.5033495310677;3559.039059453933;3561.928761424757;606.130203158469;612.1919066831739;616.981490555284;624.8843963866699;629.7323637454064;476.5972753023689;521.7495602110932;540.8269353806822;565.4430386069718;586.3169407640137;8602.95698521516;9147.725568232963;9165.762622046072;9242.676506322381;9303.302252331103;503.46632569476475;525.9691005628933;542.6852425593147;572.6220694341714;599.9520038396918;3232.8868489603224;3948.2103579284258;4063.2889244382113;4122.237386083524;4134.565870583606;78667.42665146665;89658.55170724104;90539.54730226306;90711;91605.083949161;75384;75604.62197688976;75630.24369756342;77590;78122.21877781149;64913.67543162254;67305.32694673089;67611.32388676149;67720.3227967714;68237;8799.604017819342;8857.99047076799;8871.64513419456;8874.64501419936;8959.596818143329;43874.561254388325;44292;46794.06411871812;47050.52949470461;47600.523994759606;65246;66465;66838;70234.64882675758;70705.29294706987;10725.302855314692;11005.889941100486;11218.99029087386;11382.715432114263;11738.093116727496;12128.09039322072;12152.635420937386;12309.322987235788;12335.013198944242;12415.503379865066;11583.942080289544;11586.073114151017;11621.941890290494;11659.941700291443;11798.469068891749;9929.553170107218;11262.774744505228;11356.148288878201;11814.468348924147;11874.346910919983;9256.676016339396;9512.2865785065;11214.046806021579;11556.768864622492;11559.19085664029;8467.153284671484;9325.347225694408;9407.764805879908;9428.003391225582;9700.175485083564;9296.767580810534;9313;9722.951385243028;9795.06946840049;9811.313208075366 03:10:19 INFO - PROCESS | 2113 | __end_tp_report 03:10:19 INFO - PROCESS | 2113 | __start_cc_report 03:10:19 INFO - PROCESS | 2113 | _x_x_mozilla_cycle_collect,370 03:10:19 INFO - PROCESS | 2113 | __end_cc_report 03:10:19 INFO - PROCESS | 2113 | __startTimestamp1455102619552__endTimestamp 03:10:19 INFO - PROCESS | 2113 | 03:10:19 INFO - PROCESS | 2113 | ------- Summary: start ------- 03:10:19 INFO - PROCESS | 2113 | Number of tests: 6 03:10:19 INFO - PROCESS | 2113 | 03:10:19 INFO - PROCESS | 2113 | [#0] dojo.html Cycles:165 Average:5666.93 Median:5939.85 stddev:764.14 (12.9%) stddev-sans-first:743.20 03:10:19 INFO - PROCESS | 2113 | Values: 3280.8 3489.7 3522.0 3523.2 3524.1 4701.4 5669.9 5698.4 5735.8 5750.7 5502.6 5560.4 5714.6 5737.4 5939.9 5115.4 5167.8 5177.7 5196.7 5237.7 527.4 5203.6 5227.3 5232.9 5235.6 4371.6 4735.7 5140.4 5178.5 5194.5 5101.2 5210.5 5214.0 5221.1 5229.1 5037.6 5092.5 5150.8 5170.7 5198.1 5518.3 5598.6 5666.4 5715.1 5723.4 6072.3 6133.4 6223.1 6226.5 6230.5 6257.3 6272.7 6280.5 6287.8 6313.2 5800.5 5801.9 5818.2 5842.8 5854.1 5519.5 6160.5 6190.2 6263.2 6284.2 5926.3 6125.2 6139.6 6156.5 6158.4 6099.7 6242.3 6258.7 6272.9 6280.3 6164.5 6172.7 6180.2 6210.1 6221.1 6191.1 6224.9 6229.1 6230.2 6289.8 4759.2 4853.5 4879.9 4932.5 4965.8 3725.8 4356.2 4392.8 4398.8 4404.8 5456.9 5698.5 5720.5 5763.5 5781.7 5132.4 5590.0 6219.6 6258.3 6306.9 5698.2 5726.8 5735.8 5740.4 5762.8 5246.6 5331.3 5360.4 5449.4 5470.9 6248.6 6249.9 6268.5 6278.0 6302.4 6138.3 6143.5 6183.1 6186.6 6205.6 6125.1 6196.2 6239.0 6243.2 6254.0 6161.3 6163.4 6170.7 6175.1 6193.5 6119.1 6135.0 6197.2 6206.9 6246.9 5995.1 6020.5 6099.3 6130.2 6144.9 6039.1 6054.8 6080.0 6088.2 6124.5 5873.4 5892.7 5948.6 6006.1 6055.0 5378.5 6092.6 6096.5 6099.4 6120.0 5902.7 5970.4 5972.0 5977.7 5982.8 03:10:19 INFO - PROCESS | 2113 | 03:10:19 INFO - PROCESS | 2113 | [#1] ext.html Cycles:180 Average:59767.30 Median:35853.73 stddev:121667.40 (339.3%) stddev-sans-first:121927.19 03:10:19 INFO - PROCESS | 2113 | Values: 445.8 464.6 524.4 565.6 588.5 33022.5 37325.6 37361.3 37448.6 37521.0 38565.4 39077.6 39089.2 39123.6 39333.0 9358.5 9507.8 9536.0 9593.2 9619.5 9412.3 9681.9 9716.0 9723.0 9742.7 9673.4 9776.4 9786.5 9800.3 9802.8 9638.2 9671.8 9726.0 9741.7 9797.1 9518.3 9633.5 9654.1 9678.5 9691.7 37127.6 37366.6 37519.4 37645.8 37810.8 2813.3 2875.2 3327.5 3406.7 3432.9 26753.6 27050.3 27270.0 27690.2 28057.9 2741.8 2745.1 2793.2 2913.3 2945.6 348113.0 349501.0 350534.0 351676.0 476526.0 57190.4 62663.4 63598.4 63731.0 63829.0 58329.0 61497.7 61752.4 61877.0 61905.4 15709.7 15793.5 15923.4 16096.7 16098.9 12145.8 12285.7 12325.5 12372.0 12580.5 19482.4 19527.4 19691.5 19698.6 19759.6 8553.1 8657.0 8733.9 8775.3 8785.7 903.3 916.1 1063.8 1090.6 1161.7 23924.1 28969.3 29313.3 29721.6 29780.4 1028.9 1084.9 1110.6 1142.8 1183.9 12978.8 14887.4 14953.8 15032.3 15148.2 425054.0 523049.0 524142.4 525347.0 526036.0 55800.2 56115.7 56200.2 56461.7 56496.2 1417.7 1433.8 1441.4 1442.3 1537.0 25293.4 28711.0 28885.8 29467.0 29640.6 49455.5 49559.5 49973.3 50024.5 50113.5 475759.0 477764.0 478308.0 480657.0 480991.0 32019.8 32876.8 32913.0 32960.7 32964.7 41090.8 42738.8 43232.9 43348.1 43434.2 34154.7 34863.5 35016.3 36016.0 36541.6 35006.1 35277.0 35418.5 35450.8 35597.8 35143.8 35338.0 35570.8 35626.3 35691.5 26315.9 31678.5 31873.3 31992.5 32020.2 24115.7 24280.8 24349.0 24528.3 24750.4 03:10:19 INFO - PROCESS | 2113 | 03:10:19 INFO - PROCESS | 2113 | [#2] jquery.html Cycles:180 Average:36975.02 Median:357.51 stddev:123178.38 (34454.3%) stddev-sans-first:123493.22 03:10:19 INFO - PROCESS | 2113 | Values: 352.1 356.1 358.9 360.5 360.8 15256.7 18346.4 19255.3 19320.5 20342.0 11652.7 18370.5 18547.4 19057.9 19083.2 5365.4 5523.6 5525.8 5527.4 5558.2 4673.8 5162.9 5422.0 5437.9 5445.4 3969.7 5412.9 5424.5 5429.2 5832.0 5976.1 6015.2 6051.1 6067.2 6100.7 5664.8 5697.5 5700.5 5760.9 5766.6 13293.7 19417.7 23513.8 24181.5 24464.8 2142.2 2203.7 2228.5 2265.4 2630.4 9709.3 9886.2 10273.0 10307.7 10355.1 1537.2 1544.5 1790.7 1812.7 1818.5 95899.5 98993.0 99152.0 100330.0 100555.5 11049.3 11244.9 11351.7 11377.4 11474.2 12518.9 13040.9 13155.0 13462.9 13534.3 6963.8 8096.6 8261.9 8284.9 8342.5 8434.7 8483.5 8505.3 8515.2 8517.5 4357.5 4369.4 4373.6 4378.4 4442.2 1688.1 1837.2 1893.3 1897.9 1933.6 759.8 885.3 889.4 903.6 993.8 13003.4 15203.8 17756.0 19069.8 19113.9 912.4 920.5 943.6 943.7 944.6 10224.9 10270.1 10368.0 10603.4 10820.5 735810.0 742020.0 744131.0 755606.0 766194.0 89368.6 105591.9 108615.5 120773.2 122284.4 1117.2 1163.6 1163.7 1169.0 1172.6 15042.3 18037.5 18089.7 18346.1 18497.8 47628.0 48961.8 49532.3 49607.8 50315.5 54319.0 62160.0 65500.0 67044.3 71518.6 7544.2 7691.5 7703.3 7779.6 7787.3 10663.0 10668.7 10697.4 11597.7 11758.1 9977.3 10017.5 10260.7 10601.8 10637.5 8265.6 9868.6 9884.7 10139.5 10620.4 10118.1 10193.7 10406.3 10783.1 10792.0 6665.2 7339.8 7482.6 7592.3 7656.9 8079.6 10516.6 10583.0 10594.3 10597.7 03:10:19 INFO - PROCESS | 2113 | 03:10:19 INFO - PROCESS | 2113 | [#3] mootools.html Cycles:180 Average:6047.19 Median:5419.63 stddev:3171.10 (58.5%) stddev-sans-first:3161.62 03:10:19 INFO - PROCESS | 2113 | Values: 1504.9 1535.9 1735.3 1855.8 1875.3 7373.9 7931.0 8691.0 8761.2 8911.4 8313.8 8590.9 8743.4 8750.7 8753.7 2436.0 2448.6 2477.6 2481.7 2496.2 2432.0 2474.9 2487.2 2491.6 2492.2 2188.5 2401.1 2452.5 2459.1 2475.4 2107.5 2396.7 2406.6 2439.1 2452.7 2438.5 2450.5 2453.4 2459.4 2469.4 8632.7 8641.9 8707.3 8718.1 8735.1 5347.4 5434.7 5486.2 5508.4 5527.6 3294.9 3515.0 3678.5 3737.7 3755.5 1053.9 1072.4 1078.8 1105.8 1106.9 11875.5 11877.0 11929.2 12033.6 12069.9 4853.9 4896.0 4925.7 4985.1 5010.5 9984.6 10045.6 10188.8 10207.8 10220.2 5388.2 5404.5 5466.8 5482.5 5490.8 4859.0 4934.7 4949.8 4970.9 4989.0 3926.3 3964.9 3978.7 3999.1 4014.8 1080.5 1304.6 1330.9 1332.9 1341.8 956.7 1078.9 1086.4 1177.4 1317.9 7893.5 7895.3 7928.5 7989.0 8264.2 1174.3 1180.9 1199.0 1206.4 1208.8 6270.5 6286.0 6319.6 6324.5 6347.0 10431.5 10622.2 10753.5 10794.2 10912.5 10445.9 10646.0 10671.4 10734.0 10765.6 8238.7 8322.5 8424.9 8491.7 8520.9 7897.1 7934.4 7978.8 8008.0 8008.3 9250.5 9535.4 9634.1 9742.6 9835.0 9168.3 9718.9 9768.6 9833.0 9912.0 7385.5 7459.1 7514.0 7534.4 7556.5 8010.4 8017.2 8055.5 8096.0 8106.2 7058.6 7638.5 7679.9 7721.7 7804.9 5939.8 7370.7 7420.6 7490.8 7505.8 6807.4 7349.7 7635.5 7708.8 7717.7 6826.6 6901.0 6906.3 6951.9 6970.8 7026.3 7093.9 7173.7 7198.5 7205.9 03:10:19 INFO - PROCESS | 2113 | 03:10:19 INFO - PROCESS | 2113 | [#4] prototype.html Cycles:180 Average:5862.62 Median:6471.90 stddev:1923.15 (29.7%) stddev-sans-first:1883.06 03:10:19 INFO - PROCESS | 2113 | Values: 322.8 328.7 332.5 335.7 337.5 5567.4 6542.9 6771.3 6843.6 6901.3 4796.9 5258.9 5962.5 6719.6 6774.3 4366.5 4973.0 5068.9 5094.7 5097.9 5092.9 5098.0 5100.2 5104.4 5119.7 4728.7 4887.6 4895.1 4899.5 4912.1 4456.9 4578.5 4876.8 4884.6 4886.6 4159.0 4177.5 4178.3 4178.5 4187.4 6368.7 6588.8 6594.8 6627.6 6655.6 5066.9 5841.7 5855.2 5863.6 5870.1 5926.3 7280.6 7282.2 7294.2 7332.8 3855.7 4663.5 4669.8 4676.2 4680.5 7463.8 7678.6 7806.8 7809.2 7822.9 4673.4 4715.0 4722.2 4732.8 4754.5 4188.1 4794.3 4810.0 4810.6 4830.6 4873.5 5485.5 5795.9 5796.5 5801.3 6323.6 6974.5 7313.2 7328.7 7329.9 1571.3 1629.8 1671.9 1674.2 1676.1 1034.0 1051.9 1064.2 1068.3 1069.5 5468.9 5648.2 6072.7 6176.3 6726.3 7597.8 7611.9 7613.6 7616.5 7650.3 5567.0 6400.9 6629.1 6710.7 6791.8 4009.6 4032.4 4044.6 4045.8 4048.1 7907.0 7910.5 7932.5 7933.5 7980.2 7509.8 7815.2 7815.5 7820.0 7870.8 7881.0 7897.8 7903.4 7913.2 7918.1 6643.7 7247.3 7557.4 7599.9 7621.8 6884.3 7086.0 7177.5 7464.1 7484.1 6394.3 7867.1 7867.5 7889.9 7902.8 4737.5 4745.9 4748.8 4760.3 4776.6 7314.3 7385.3 7531.1 7652.4 7662.7 7339.6 7412.8 7423.9 7425.3 7490.5 6189.8 7428.3 7440.6 7443.7 7457.6 6938.2 7241.7 7261.6 7265.2 7271.2 6096.9 7400.3 7408.4 7424.3 7438.4 7043.4 7215.5 7252.4 7255.4 7292.5 03:10:19 INFO - PROCESS | 2113 | 03:10:19 INFO - PROCESS | 2113 | [#5] yui.html Cycles:180 Average:17923.52 Median:32771.70 stddev:25016.02 (76.3%) stddev-sans-first:25052.61 03:10:19 INFO - PROCESS | 2113 | Values: 660.6 694.4 723.7 725.4 734.9 14529.3 14685.3 14688.4 14732.4 14820.8 13509.6 13921.4 14047.5 14048.9 14070.6 677.2 832.4 839.6 848.6 864.2 852.4 863.7 864.1 864.4 867.0 902.4 903.5 904.7 906.5 909.3 893.3 894.9 895.0 895.8 896.9 666.4 666.7 666.7 667.3 669.1 14250.4 14440.9 14558.5 14615.3 14645.9 12622.3 12670.6 12739.2 12972.7 12985.0 8713.8 9942.4 10318.9 10332.8 10376.9 3549.4 3579.0 3584.6 3592.1 3606.8 80258.0 80264.2 80488.6 82225.6 82637.6 9379.8 9410.9 9596.3 9683.2 10018.9 18408.5 19158.0 20438.9 20604.6 20671.3 7447.4 7595.2 7606.0 7691.2 7963.0 3517.4 4095.7 4128.1 4137.9 4157.9 3514.0 3544.6 3547.5 3559.0 3561.9 606.1 612.2 617.0 624.9 629.7 476.6 521.7 540.8 565.4 586.3 8603.0 9147.7 9165.8 9242.7 9303.3 503.5 526.0 542.7 572.6 600.0 3232.9 3948.2 4063.3 4122.2 4134.6 78667.4 89658.6 90539.5 90711.0 91605.1 75384.0 75604.6 75630.2 77590.0 78122.2 64913.7 67305.3 67611.3 67720.3 68237.0 8799.6 8858.0 8871.6 8874.6 8959.6 43874.6 44292.0 46794.1 47050.5 47600.5 65246.0 66465.0 66838.0 70234.6 70705.3 10725.3 11005.9 11219.0 11382.7 11738.1 12128.1 12152.6 12309.3 12335.0 12415.5 11583.9 11586.1 11621.9 11659.9 11798.5 9929.6 11262.8 11356.1 11814.5 11874.3 9256.7 9512.3 11214.0 11556.8 11559.2 8467.2 9325.3 9407.8 9428.0 9700.2 9296.8 9313.0 9723.0 9795.1 9811.3 03:10:19 INFO - PROCESS | 2113 | -------- Summary: end -------- 03:10:19 INFO - PROCESS | 2113 | 03:10:20 INFO - TEST-INFO | 2113: exit 0 03:10:20 INFO - TEST-OK | dromaeo_css | took 1110433ms 03:10:20 INFO - TEST-START | kraken 03:10:20 INFO - operating with platform_type : mac_ 03:10:20 INFO - Initialising browser for kraken test... 03:10:20 INFO - TEST-INFO | started process 2118 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmp4Pg1e_/profile http://localhost:49374/getInfo.html) 03:10:23 INFO - PROCESS | 2118 | __metrics Screen width/height:1600/1200 03:10:23 INFO - PROCESS | 2118 | colorDepth:24 03:10:23 INFO - PROCESS | 2118 | Browser inner width/height: 1024/689 03:10:23 INFO - PROCESS | 2118 | __metrics 03:10:23 INFO - TEST-INFO | 2118: exit 0 03:10:23 INFO - Browser initialized. 03:10:23 INFO - Running cycle 1/1 for kraken test... 03:10:23 INFO - TEST-INFO | started process 2121 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmp4Pg1e_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:10:35 INFO - PROCESS | 2121 | RSS: Main: 259153920 03:10:35 INFO - PROCESS | 2121 | 03:10:38 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-beat-detection) 03:10:38 INFO - PROCESS | 2121 | RSS: Main: 269660160 03:10:38 INFO - PROCESS | 2121 | 03:10:41 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-dft) 03:10:42 INFO - PROCESS | 2121 | RSS: Main: 279109632 03:10:42 INFO - PROCESS | 2121 | 03:10:45 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-fft) 03:10:46 INFO - PROCESS | 2121 | RSS: Main: 281358336 03:10:46 INFO - PROCESS | 2121 | 03:10:48 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-oscillator) 03:10:48 INFO - PROCESS | 2121 | RSS: Main: 282230784 03:10:48 INFO - PROCESS | 2121 | 03:10:51 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49374/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:10:51 INFO - PROCESS | 2121 | RSS: Main: 282931200 03:10:51 INFO - PROCESS | 2121 | 03:10:54 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49374/tests/kraken/driver.html?testName=imaging-darkroom) 03:10:54 INFO - PROCESS | 2121 | RSS: Main: 284114944 03:10:54 INFO - PROCESS | 2121 | 03:10:57 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49374/tests/kraken/driver.html?testName=imaging-desaturate) 03:10:58 INFO - PROCESS | 2121 | RSS: Main: 285237248 03:10:58 INFO - PROCESS | 2121 | 03:11:01 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49374/tests/kraken/driver.html?testName=json-parse-financial) 03:11:01 INFO - PROCESS | 2121 | RSS: Main: 286212096 03:11:01 INFO - PROCESS | 2121 | 03:11:03 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49374/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:11:03 INFO - PROCESS | 2121 | RSS: Main: 284176384 03:11:03 INFO - PROCESS | 2121 | 03:11:05 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:11:06 INFO - PROCESS | 2121 | RSS: Main: 284852224 03:11:06 INFO - PROCESS | 2121 | 03:11:08 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:11:09 INFO - PROCESS | 2121 | RSS: Main: 285564928 03:11:09 INFO - PROCESS | 2121 | 03:11:11 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:11:12 INFO - PROCESS | 2121 | RSS: Main: 285138944 03:11:12 INFO - PROCESS | 2121 | 03:11:14 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:11:15 INFO - PROCESS | 2121 | RSS: Main: 286486528 03:11:15 INFO - PROCESS | 2121 | 03:11:17 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49374/tests/kraken/driver.html?testName=ai-astar) 03:11:17 INFO - PROCESS | 2121 | RSS: Main: 286134272 03:11:17 INFO - PROCESS | 2121 | 03:11:17 INFO - PROCESS | 2121 | __start_tp_report 03:11:17 INFO - PROCESS | 2121 | _x_x_mozilla_page_load 03:11:17 INFO - PROCESS | 2121 | _x_x_mozilla_page_load_details 03:11:17 INFO - PROCESS | 2121 | |i|pagename|runs| 03:11:17 INFO - PROCESS | 2121 | |0;ai-astar;116;106;115;114;115;126;115;116;115;116 03:11:17 INFO - PROCESS | 2121 | |1;audio-beat-detection;157;149;149;152;120;168;163;123;155;123 03:11:17 INFO - PROCESS | 2121 | |2;audio-dft;198;202;203;199;213;232;256;274;206;197 03:11:17 INFO - PROCESS | 2121 | |3;audio-fft;70;69;71;113;62;58;65;84;167;57 03:11:17 INFO - PROCESS | 2121 | |4;audio-oscillator;83;83;151;114;115;67;137;119;120;150 03:11:17 INFO - PROCESS | 2121 | |5;imaging-gaussian-blur;87;93;87;94;88;92;86;93;88;92 03:11:17 INFO - PROCESS | 2121 | |6;imaging-darkroom;95;96;96;95;95;96;96;97;119;94 03:11:17 INFO - PROCESS | 2121 | |7;imaging-desaturate;91;94;92;92;93;92;88;96;96;92 03:11:17 INFO - PROCESS | 2121 | |8;json-parse-financial;56;57;56;57;60;57;59;66;66;75 03:11:17 INFO - PROCESS | 2121 | |9;json-stringify-tinderbox;66;85;106;95;76;71;69;68;69;67 03:11:17 INFO - PROCESS | 2121 | |10;stanford-crypto-aes;75;106;72;73;108;100;106;109;108;109 03:11:17 INFO - PROCESS | 2121 | |11;stanford-crypto-ccm;128;130;126;128;126;127;124;122;114;163 03:11:17 INFO - PROCESS | 2121 | |12;stanford-crypto-pbkdf2;131;144;179;137;139;129;141;159;144;129 03:11:17 INFO - PROCESS | 2121 | |13;stanford-crypto-sha256-iterative;65;70;65;70;66;68;66;70;67;99 03:11:17 INFO - PROCESS | 2121 | __end_tp_report 03:11:17 INFO - PROCESS | 2121 | __start_cc_report 03:11:17 INFO - PROCESS | 2121 | _x_x_mozilla_cycle_collect,940 03:11:17 INFO - PROCESS | 2121 | __end_cc_report 03:11:17 INFO - PROCESS | 2121 | __startTimestamp1455102677509__endTimestamp 03:11:17 INFO - PROCESS | 2121 | 03:11:17 INFO - PROCESS | 2121 | ------- Summary: start ------- 03:11:17 INFO - PROCESS | 2121 | Number of tests: 14 03:11:17 INFO - PROCESS | 2121 | 03:11:17 INFO - PROCESS | 2121 | [#0] ai-astar Cycles:10 Average:115.40 Median:115.50 stddev:4.77 (4.1%) stddev-sans-first:5.05 03:11:17 INFO - PROCESS | 2121 | Values: 116.0 106.0 115.0 114.0 115.0 126.0 115.0 116.0 115.0 116.0 03:11:17 INFO - PROCESS | 2121 | 03:11:17 INFO - PROCESS | 2121 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:153.50 stddev:17.52 (11.4%) stddev-sans-first:18.12 03:11:17 INFO - PROCESS | 2121 | Values: 157.0 149.0 149.0 152.0 120.0 168.0 163.0 123.0 155.0 123.0 03:11:17 INFO - PROCESS | 2121 | 03:11:17 INFO - PROCESS | 2121 | [#2] audio-dft Cycles:10 Average:218.00 Median:209.50 stddev:27.14 (13.0%) stddev-sans-first:27.80 03:11:17 INFO - PROCESS | 2121 | Values: 198.0 202.0 203.0 199.0 213.0 232.0 256.0 274.0 206.0 197.0 03:11:17 INFO - PROCESS | 2121 | 03:11:17 INFO - PROCESS | 2121 | [#3] audio-fft Cycles:10 Average:81.60 Median:67.00 stddev:34.18 (51.0%) stddev-sans-first:35.99 03:11:17 INFO - PROCESS | 2121 | Values: 70.0 69.0 71.0 113.0 62.0 58.0 65.0 84.0 167.0 57.0 03:11:17 INFO - PROCESS | 2121 | 03:11:17 INFO - PROCESS | 2121 | [#4] audio-oscillator Cycles:10 Average:113.90 Median:150.50 stddev:28.65 (19.0%) stddev-sans-first:28.12 03:11:17 INFO - PROCESS | 2121 | Values: 83.0 83.0 151.0 114.0 115.0 67.0 137.0 119.0 120.0 150.0 03:11:17 INFO - PROCESS | 2121 | 03:11:17 INFO - PROCESS | 2121 | [#5] imaging-gaussian-blur Cycles:10 Average:90.00 Median:92.00 stddev:3.06 (3.3%) stddev-sans-first:3.04 03:11:17 INFO - PROCESS | 2121 | Values: 87.0 93.0 87.0 94.0 88.0 92.0 86.0 93.0 88.0 92.0 03:11:17 INFO - PROCESS | 2121 | 03:11:17 INFO - PROCESS | 2121 | [#6] imaging-darkroom Cycles:10 Average:97.90 Median:96.00 stddev:7.46 (7.8%) stddev-sans-first:7.84 03:11:17 INFO - PROCESS | 2121 | Values: 95.0 96.0 96.0 95.0 95.0 96.0 96.0 97.0 119.0 94.0 03:11:17 INFO - PROCESS | 2121 | 03:11:17 INFO - PROCESS | 2121 | [#7] imaging-desaturate Cycles:10 Average:92.60 Median:92.50 stddev:2.37 (2.6%) stddev-sans-first:2.44 03:11:17 INFO - PROCESS | 2121 | Values: 91.0 94.0 92.0 92.0 93.0 92.0 88.0 96.0 96.0 92.0 03:11:17 INFO - PROCESS | 2121 | 03:11:17 INFO - PROCESS | 2121 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:59.50 stddev:6.23 (10.5%) stddev-sans-first:6.35 03:11:17 INFO - PROCESS | 2121 | Values: 56.0 57.0 56.0 57.0 60.0 57.0 59.0 66.0 66.0 75.0 03:11:17 INFO - PROCESS | 2121 | 03:11:17 INFO - PROCESS | 2121 | [#9] json-stringify-tinderbox Cycles:10 Average:77.20 Median:70.00 stddev:13.73 (19.6%) stddev-sans-first:13.95 03:11:17 INFO - PROCESS | 2121 | Values: 66.0 85.0 106.0 95.0 76.0 71.0 69.0 68.0 69.0 67.0 03:11:17 INFO - PROCESS | 2121 | 03:11:17 INFO - PROCESS | 2121 | [#10] stanford-crypto-aes Cycles:10 Average:96.60 Median:109.00 stddev:16.28 (14.9%) stddev-sans-first:15.27 03:11:17 INFO - PROCESS | 2121 | Values: 75.0 106.0 72.0 73.0 108.0 100.0 106.0 109.0 108.0 109.0 03:11:17 INFO - PROCESS | 2121 | 03:11:17 INFO - PROCESS | 2121 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:127.50 stddev:12.82 (10.1%) stddev-sans-first:13.60 03:11:17 INFO - PROCESS | 2121 | Values: 128.0 130.0 126.0 128.0 126.0 127.0 124.0 122.0 114.0 163.0 03:11:17 INFO - PROCESS | 2121 | 03:11:17 INFO - PROCESS | 2121 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.20 Median:142.50 stddev:15.44 (10.8%) stddev-sans-first:15.73 03:11:17 INFO - PROCESS | 2121 | Values: 131.0 144.0 179.0 137.0 139.0 129.0 141.0 159.0 144.0 129.0 03:11:17 INFO - PROCESS | 2121 | 03:11:17 INFO - PROCESS | 2121 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:69.00 stddev:10.18 (14.8%) stddev-sans-first:10.59 03:11:17 INFO - PROCESS | 2121 | Values: 65.0 70.0 65.0 70.0 66.0 68.0 66.0 70.0 67.0 99.0 03:11:17 INFO - PROCESS | 2121 | -------- Summary: end -------- 03:11:17 INFO - PROCESS | 2121 | 03:11:18 INFO - TEST-INFO | 2121: exit 0 03:11:18 INFO - TEST-OK | kraken | took 58215ms 03:11:18 INFO - SUITE-END | took 1168s 03:11:18 INFO - Completed test suite (00:19:29) 03:11:18 INFO - Working with test: dromaeo_css 03:11:18 INFO - Generating results file: dromaeo_css 03:11:18 INFO - Working with test: kraken 03:11:18 INFO - Generating results file: kraken 03:11:18 INFO - javascript benchmark 03:11:18 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:11:19 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 03:11:19 INFO - process_Request line: dromaeo_css 7440.16 graph.html#tests=[[72,64,61]] 03:11:19 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:11:19 INFO - process_Request line: kraken 1532.60 graph.html#tests=[[232,64,61]] 03:11:19 INFO - RETURN: dromaeo_css: 7440.16 03:11:19 INFO - RETURN: kraken: 1532.60 03:11:19 INFO - javascript benchmark 03:11:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3280.8031518108914, 3489.6510348965107, 3521.9647803521975, 3523.207278362369, 3524.136586536299, 4701.435827700677, 5669.858253543658, 5698.401667824881, 5735.827925162242, 5750.712464376786, 5502.58730595205, 5560.4161563035905, 5714.628549144302, 5737.397573254801, 5939.85150371241, 5115.411727651312, 5167.844964651066, 5177.715225662587, 5196.688198708071, 5237.685738855662, 527.40330499025, 5203.60972927032, 5227.32044834171, 5232.947670523303, 5235.633505654606, 4371.562843715635, 4735.721355234102, 5140.3831540215415, 5178.48215178481, 5194.480551944813, 5101.20931255656, 5210.53105220532, 5213.973930130363, 5221.112410890158, 5229.137192363255, 5037.622178336639, 5092.516210959953, 5150.819721309774, 5170.715610641413, 5198.090334191501, 5518.2826232589905, 5598.608097433182, 5666.376698563155, 5715.057015592422, 5723.370429252779, 6072.2713274406915, 6133.3559976202305, 6223.097650840648, 6226.533010024266, 6230.470410015108, 6257.280412752546, 6272.686365681698, 6280.528960327948, 6287.779927702509, 6313.179286692746, 5800.506956908668, 5801.88396232073, 5818.2436283282905, 5842.766289348421, 5854.063349864044, 5519.475649813261, 6160.507159427235, 6190.164327815687, 6263.185785847902, 6284.214473190851, 5926.288845338587, 6125.1731016313115, 6139.631622102688, 6156.476699480505, 6158.353372895782, 6099.695015249308, 6242.2509298883515, 6258.718357673915, 6272.937270627326, 6280.309165991737, 6164.4760195383, 6172.660503672341, 6180.165677633552, 6210.099535567318, 6221.09794079865, 6191.071339299141, 6224.937750622526, 6229.127922090911, 6230.190075290183, 6289.842753931189, 4759.190937540627, 4853.490383509751, 4879.877628145476, 4932.53140951609, 4965.776540055634, 3725.8137093145233, 4356.215881141425, 4392.846250381222, 4398.824047038147, 4404.823807047682, 5456.945430545723, 5698.515626171822, 5720.496367978412, 5763.452472015152, 5781.682007489544, 5132.409772876167, 5589.972050139804, 6219.626822390671, 6258.311585725566, 6306.873862522724, 5698.202251684685, 5726.828195154152, 5735.827925162252, 5740.368559458456, 5762.827115186551, 5246.63273570854, 5331.253624492574, 5360.410354860962, 5449.427810079964, 5470.91793623096, 6248.562600617913, 6249.937500625027, 6268.4671802896355, 6277.96861015692, 6302.401271879165, 6138.324784273816, 6143.501336845131, 6183.103449999815, 6186.566940314135, 6205.596636218631, 6125.05232106189, 6196.1635179250225, 6239.001759718423, 6243.219597550306, 6253.96873015632, 6161.291451483136, 6163.445289923929, 6170.6914654268, 6175.104609831459, 6193.473554747897, 6119.082137679384, 6135.04893764628, 6197.194364732556, 6206.906896396648, 6246.906296405648, 5995.100734889627, 6020.51835853122, 6099.340048627855, 6130.172426722514, 6144.877102457836, 6039.063945088518, 6054.788082417094, 6080.0, 6088.238970128734, 6124.510039196943, 5873.3832947541605, 5892.734826932884, 5948.643081415129, 6006.069059295816, 6055.031195008954, 5378.515933565998, 6092.603980741238, 6096.542759292982, 6099.359567245376, 6119.990201616683, 5902.675352855634, 5970.373110823301, 5971.954907891189, 5977.671228082497, 5982.760689572368], "unit": "score", "name": "dojo.html", "value": 5620.841901085761}, {"lowerIsBetter": false, "replicates": [445.77933922708246, 464.6097278286239, 524.4205153305599, 565.6351653183697, 588.4527389527743, 33022.50466243005, 37325.62674373255, 37361.25277494452, 37448.62551374489, 37521.0, 38565.42151867724, 39077.609223907755, 39089.21821563567, 39123.60876391242, 39333.0, 9358.53207339632, 9507.762305942337, 9535.952320238424, 9593.184579310768, 9619.519024048805, 9412.34113612044, 9681.854772178423, 9716.0, 9723.0, 9742.659006934759, 9673.37123086997, 9776.413415195075, 9786.461744604045, 9800.31397802154, 9802.803943921117, 9638.228941684683, 9671.806563868684, 9725.951370243103, 9741.707748767549, 9797.118259356692, 9518.333716639838, 9633.470159141245, 9654.082862128087, 9678.467684277362, 9691.66079187232, 37127.62872371269, 37366.62633373686, 37519.437208441894, 37645.81177094097, 37810.81094594509, 2813.2826129336886, 2875.223689603816, 3327.5341452196712, 3406.7274618030747, 3432.8970130896114, 26753.598696019577, 27050.323741906413, 27270.04554840591, 27690.169294921183, 28057.87768489258, 2741.821781584191, 2745.08039806665, 2793.2318612381555, 2913.2716820794803, 2945.587617733519, 348113.0, 349501.0, 350534.0, 351676.0, 476526.0, 57190.42809571934, 62663.373366266664, 63598.36401636017, 63731.0, 63829.0, 58329.0, 61497.69251153805, 61752.38247617556, 61877.0, 61905.38094618996, 15709.743220542328, 15793.526194213962, 15923.363065477482, 16096.71226301893, 16098.919505402398, 12145.757084858253, 12285.69285767845, 12325.50697972071, 12372.0, 12580.496780128693, 19482.4155275342, 19527.414177574694, 19691.507712307306, 19698.60602787965, 19759.60480790405, 8553.14468553152, 8657.008887955679, 8733.91266087331, 8775.297976161892, 8785.692500762443, 903.2548147777978, 916.1022198245756, 1063.7606538528769, 1090.5647211284518, 1161.6747310753003, 23924.05441174989, 28969.275768105545, 29313.267168320963, 29721.55417668737, 29780.40439191204, 1028.8733836449076, 1084.8806631270554, 1110.566878917223, 1142.765733024728, 1183.8875306845837, 12978.805317920238, 14887.404503819726, 14953.775693364609, 15032.323545440482, 15148.242587870562, 425054.0, 523049.0, 524142.3792881087, 525347.0, 526036.0, 55800.16299755507, 56115.71942140263, 56200.15699764507, 56461.71769141128, 56496.15255771167, 1417.730631180093, 1433.7777644465125, 1441.3657990484153, 1442.314900422291, 1536.9779096900436, 25293.367665808502, 28711.0, 28885.844566217114, 29466.968656096935, 29640.55539166871, 49455.50544494509, 49559.504404955485, 49973.25040124474, 50024.49975500198, 50113.498865010886, 475759.0, 477764.0, 478308.0, 480657.0, 480991.0, 32019.839900800347, 32876.835615821765, 32913.01260962175, 32960.67039329576, 32964.67035329616, 41090.79454602708, 42738.78630606827, 43232.91917702083, 43348.13303733971, 43434.19733567393, 34154.658453416145, 34863.47704784481, 35016.299674005866, 36016.0, 36541.634583653824, 35006.12484687903, 35277.0, 35418.468722969694, 35450.82274588611, 35597.82201088978, 35143.824280878434, 35338.0, 35570.822145889106, 35626.28747424985, 35691.46462803008, 26315.921032240032, 31678.524822128147, 31873.269302731696, 31992.52011219787, 32020.19949501281, 24115.744374509217, 24280.75719242785, 24349.0, 24528.264152075466, 24750.38124046913], "unit": "score", "name": "ext.html", "value": 19234.960687883322}, {"lowerIsBetter": false, "replicates": [352.07053379079235, 356.08663777410936, 358.9389803733365, 360.4971065363819, 360.8466401779245, 15256.69486610267, 18346.449606511793, 19255.326063587778, 19320.51698707533, 20341.982900854953, 11652.708682282926, 18370.540736481562, 18547.443576692687, 19057.90471047646, 19083.236670533195, 5365.436629153941, 5523.6409633373905, 5525.751341189656, 5527.364353099385, 5558.249636299089, 4673.813047478096, 5162.92255616166, 5421.972890135544, 5437.891242175154, 5445.401005889349, 3969.6625786808154, 5412.9458705412835, 5424.484673955988, 5429.158480435519, 5832.008558545058, 5976.133460648225, 6015.157877897098, 6051.12258722485, 6067.241594800672, 6100.72546735398, 5664.773409063632, 5697.4587414195585, 5700.486956173964, 5760.876629057336, 5766.596338256324, 13293.667658308523, 19417.708734368996, 23513.764862351327, 24181.516369672507, 24464.77676116187, 2142.232658057109, 2203.746569144537, 2228.5320082782637, 2265.4109931417784, 2630.395009147888, 9709.271804614682, 9886.159676427513, 10273.0, 10307.742306442324, 10355.068043876012, 1537.2083377060824, 1544.524819156897, 1790.6776780179562, 1812.6918423867974, 1818.5180927054341, 95899.52050239773, 98993.0, 99152.0, 100329.99340013159, 100555.49722251343, 11049.33703977764, 11244.943775281072, 11351.716207094889, 11377.431128443544, 11474.196806223485, 12518.937405313098, 13040.934795325962, 13155.0, 13462.932685336511, 13534.323283835769, 6963.79108626742, 8096.595170241464, 8261.917380826235, 8284.875726864102, 8342.499450033018, 8434.734789781582, 8483.490990540464, 8505.277051450696, 8515.19105684959, 8517.48895066298, 4357.455318085239, 4369.366441865912, 4373.606375426227, 4378.365137055109, 4442.200403927324, 1688.1093175643357, 1837.2283640870867, 1893.2710906301172, 1897.8576606754548, 1933.622943526027, 759.7606753872512, 885.3315746611396, 889.3552174673439, 903.584351198456, 993.7714325705128, 13003.414846331938, 15203.771943420857, 17756.023418711837, 19069.809301906804, 19113.904430478036, 912.4069354919355, 920.5305294299822, 943.5942544705842, 943.6744323208482, 944.5843828715343, 10224.897751022543, 10270.07569318765, 10368.0, 10603.363798172135, 10820.458977051116, 735810.0, 742020.0, 744131.0, 755606.0, 766194.0, 89368.5531572338, 105591.94408055974, 108615.45692271487, 120773.18840217404, 122284.38857805655, 1117.1844553476008, 1163.5752950173126, 1163.7323415614455, 1168.9590864319707, 1172.6247600767672, 15042.323095460511, 18037.458876233733, 18089.728654070463, 18346.08269586542, 18497.81502184961, 47628.0, 48961.77595560139, 49532.25701614551, 49607.75196123996, 50315.49684503255, 54319.0, 62160.0, 65500.0, 67044.32955670381, 71518.64240678764, 7544.245575442412, 7691.4615976883315, 7703.345215656732, 7779.57212353326, 7787.338076263581, 10663.0, 10668.706228160983, 10697.411642359744, 11597.710057248636, 11758.118141139277, 9977.251706121924, 10017.499125043865, 10260.692179234635, 10601.840972385575, 10637.521311541153, 8265.628046737791, 9868.605255789687, 9884.703458896245, 10139.543720532742, 10620.415877126523, 10118.08937195656, 10193.694189174337, 10406.323588966692, 10783.137349011904, 10792.0, 6665.233498147775, 7339.77980660581, 7482.588457634664, 7592.316691497571, 7656.885146722915, 8079.555624440713, 10516.57933682644, 10583.0, 10594.31136976125, 10597.682069537927], "unit": "score", "name": "jquery.html", "value": 8974.36863367372}, {"lowerIsBetter": false, "replicates": [1504.8946573739836, 1535.8804849307958, 1735.2625134317911, 1855.8144185581434, 1875.2780179630838, 7373.9307800368915, 7930.96034519828, 8691.043985161636, 8761.167689069536, 8911.376203665746, 8313.792155196123, 8590.871136932936, 8743.387962842604, 8750.737477875658, 8753.737387878375, 2435.9634605480933, 2448.5837407640697, 2477.5664258754737, 2481.6525686403916, 2496.163785131983, 2431.963520547193, 2474.938126546842, 2487.1543675150447, 2491.576432006563, 2492.190038237571, 2188.4966457714736, 2401.0635852017726, 2452.491717593685, 2459.090136649433, 2475.356407334088, 2107.546877421362, 2396.664466974625, 2406.554787364343, 2439.134107391877, 2452.730199678034, 2438.5244877248942, 2450.509898020385, 2453.411181316489, 2459.3605662527693, 2469.3949982254285, 8632.741017769476, 8641.913580864237, 8707.25988290996, 8718.084601116854, 8735.126487351214, 5347.385050719178, 5434.728263586805, 5486.204500347467, 5508.366537848158, 5527.613067085305, 3294.89620976973, 3515.0, 3678.503402040717, 3737.6636102750613, 3755.4930084438524, 1053.857729206555, 1072.3726619927352, 1078.757279612089, 1105.8341248812742, 1106.9059129973962, 11875.52497900083, 11877.049836013099, 11929.224600400947, 12033.6389908302, 12069.879301206964, 4853.927191092136, 4895.951040489621, 4925.679830811057, 4985.052839960396, 5010.473900240495, 9984.600615975425, 10045.598176072876, 10188.796224075477, 10207.846882296772, 10220.233482488844, 5388.164834450667, 5404.540614047772, 5466.808661696821, 5482.506574408322, 5490.780368785284, 4858.951410485921, 4934.7285899275885, 4949.802007919643, 4970.8757281068265, 4988.9501104988485, 3926.2736393767245, 3964.940525892114, 3978.7214894957656, 3999.1201935574127, 4014.8193331300163, 1080.4597701149426, 1304.6281809684194, 1330.8602596727205, 1332.9133606315559, 1341.7718987771907, 956.6699488676395, 1078.8813230544633, 1086.3699054548342, 1177.364223319398, 1317.914335568185, 7893.526388416713, 7895.328897043701, 7928.484648497829, 7989.041315042232, 8264.173582641808, 1174.3482367286238, 1180.893719565226, 1198.9700257493457, 1206.4209179593845, 1208.8005479096028, 6270.467010304175, 6285.96857015712, 6319.557630965788, 6324.525660575475, 6347.016212487072, 10431.530581123867, 10622.203334749925, 10753.51609177589, 10794.190435717195, 10912.526808880859, 10445.895541044645, 10646.041856232976, 10671.35971841692, 10734.033936945556, 10765.623203187852, 8238.711645092393, 8322.45904016237, 8424.915750842536, 8491.660333586711, 8520.8721869172, 7897.131315555399, 7934.444588878723, 7978.800529986796, 8007.999000124984, 8008.319292860172, 9250.491222982531, 9535.38020028696, 9634.13292803651, 9742.561584728563, 9835.016498350107, 9168.266538677024, 9718.9028109718, 9768.609255629979, 9833.0, 9912.00879912003, 7385.483016188815, 7459.067616547932, 7514.0, 7534.434917381109, 7556.508826926232, 8010.359171266401, 8017.238362355567, 8055.476394034369, 8096.0, 8106.229908158715, 7058.576485410892, 7638.50349727266, 7679.897707917977, 7721.691132354643, 7804.8829267559895, 5939.821805345847, 7370.705171793068, 7420.591867447342, 7490.812729681802, 7505.774826755206, 6807.3873351398615, 7349.713800085071, 7635.465517413728, 7708.807279818049, 7717.691292348468, 6826.556273842184, 6900.999355093383, 6906.274841141608, 6951.9304806953305, 6970.756023539152, 7026.332498412643, 7093.858122837618, 7173.713051478091, 7198.5320954137815, 7205.927940720526], "unit": "score", "name": "mootools.html", "value": 4934.4544629583925}, {"lowerIsBetter": false, "replicates": [322.7901863788538, 328.65819547670424, 332.47966931751824, 335.65427609562147, 337.5021842781897, 5567.4432556744305, 6542.887709089454, 6771.255161932184, 6843.589384636925, 6901.30986901309, 4796.856094317176, 5258.921921006194, 5962.522998160148, 6719.596824190552, 6774.288699686524, 4366.4978527469275, 4973.01079568172, 5068.898622027557, 5094.745262736848, 5097.898042039157, 5092.872678183038, 5097.974510127444, 5100.234964755279, 5104.3619547556555, 5119.667221630601, 4728.739919304437, 4887.584555312803, 4895.143349913768, 4899.51004899509, 4912.091263116317, 4456.930336719196, 4578.496365399803, 4876.804927802884, 4884.633652476043, 4886.60907127429, 4159.0, 4177.540470548268, 4178.331466965271, 4178.456800615931, 4187.392828039948, 6368.681565921732, 6588.8023359299295, 6594.835129121762, 6627.569208001512, 6655.600663960178, 5066.898662026776, 5841.678707671076, 5855.209546711225, 5863.560232982543, 5870.148828419898, 5926.348101708809, 7280.599567023812, 7282.162551306615, 7294.161171465296, 7332.78001659951, 3855.6722678572073, 4663.510331415187, 4669.836555720567, 4676.205045142334, 4680.485146633868, 7463.813404664873, 7678.616069196573, 7806.765797026098, 7809.2190780921455, 7822.882656760153, 4673.392458980379, 4714.95285047152, 4722.173619616622, 4732.787024583902, 4754.453237877619, 4188.099558594856, 4794.304825800309, 4809.951900480951, 4810.5670489656095, 4830.637702172351, 4873.488283730228, 5485.50630443262, 5795.9277533656405, 5796.5072968797285, 5801.3328467225965, 6323.588966717149, 6974.465617564128, 7313.195548489662, 7328.67020984057, 7329.853402931912, 1571.2615070916652, 1629.8451647093507, 1671.8746094042995, 1674.1880188108757, 1676.1451659653665, 1033.994830025845, 1051.8790339111101, 1064.2071656615872, 1068.316277582348, 1069.4706120470416, 5468.890622187534, 5648.209250704905, 6072.696365181811, 6176.320604733476, 6726.293739157416, 7597.848043039219, 7611.923880761122, 7613.581253031137, 7616.504927179715, 7650.349720273728, 5566.972165139148, 6400.9039864402075, 6629.141347029585, 6710.664466776641, 6791.830204244933, 4009.578994205625, 4032.354823228269, 4044.6359827615656, 4045.7774822384463, 4048.0891799344913, 7907.0, 7910.485818421784, 7932.484388514844, 7933.484323518953, 7980.241877021674, 7509.774706758806, 7815.179406162385, 7815.491993020435, 7819.960900195462, 7870.780029095499, 7881.0, 7897.802554936173, 7903.407244456574, 7913.208679132041, 7918.129005809356, 6643.734250629921, 7247.311505406978, 7557.395408367208, 7599.88600171009, 7621.809454763676, 6884.311568843075, 7085.964570177116, 7177.4616903731385, 7464.141623713125, 7484.064491938508, 6394.328595497405, 7867.095284042409, 7867.488613240121, 7889.921100788919, 7902.841943161219, 4737.478877323423, 4745.928811067768, 4748.833790817304, 4760.309755085424, 4776.641751868554, 7314.268573142643, 7385.261473852786, 7531.133919599316, 7652.38780897538, 7662.73180438682, 7339.6330183489545, 7412.814679633052, 7423.888641670272, 7425.257474252531, 7490.475666703279, 6189.76204759059, 7428.33145016951, 7440.627968601657, 7443.739469118555, 7457.552546847207, 6938.202106757787, 7241.746538871114, 7261.6006119661815, 7265.20082790882, 7271.163816160997, 6096.908546371719, 7400.333969942731, 7408.370288525536, 7424.294692004251, 7438.404927605887, 7043.36609705129, 7215.458840587082, 7252.383547398319, 7255.383292419992, 7292.453066019963], "unit": "score", "name": "prototype.html", "value": 5222.981910365297}, {"lowerIsBetter": false, "replicates": [660.5805313625848, 694.3507820188124, 723.7286017743346, 725.4196642685852, 734.9338559529641, 14529.273536323168, 14685.265736713149, 14688.41246350146, 14732.410703571857, 14820.777688334683, 13509.555063458803, 13921.37353819078, 14047.508337208199, 14048.859511404882, 14070.57788266351, 677.2347247610194, 832.3840358134981, 839.5802098950525, 848.5672307123381, 864.2481041493909, 852.4075767341669, 863.7365603490932, 864.0883867519764, 864.356054739217, 866.9913300867005, 902.4044130873625, 903.503073309677, 904.7466709321368, 906.5331354352513, 909.3316412436886, 893.2809088683607, 894.9328800339968, 895.042304733935, 895.8342706599267, 896.8699538566937, 666.4135560706595, 666.7066490744057, 666.7066490744105, 667.302668711198, 669.0967194287673, 14250.358733857001, 14440.927795361062, 14558.4904528341, 14615.269236538237, 14645.853541464556, 12622.305773182472, 12670.619881403572, 12739.171953822972, 12972.675683107998, 12985.0, 8713.825723485495, 9942.403455792602, 10318.948405258001, 10332.79334413315, 10376.896231037668, 3549.4498352755363, 3578.964210357889, 3584.551931008624, 3592.119930616989, 3606.8376923038527, 80258.0, 80264.19735802626, 80488.59755701185, 82225.58887205645, 82637.58681206616, 9379.765505862271, 9410.858837117448, 9596.335926400616, 9683.225341972626, 10018.899811001942, 18408.53978650518, 19158.0, 20438.875861827444, 20604.587908241752, 20671.276505322243, 7447.441441891771, 7595.240475952471, 7606.0, 7691.1924247954275, 7962.960185199037, 3517.43721004638, 4095.672346212296, 4128.091819799639, 4137.855175068858, 4157.8960525987095, 3513.9648603513638, 3544.5923718772156, 3547.5033495310677, 3559.039059453933, 3561.928761424757, 606.130203158469, 612.1919066831739, 616.981490555284, 624.8843963866699, 629.7323637454064, 476.5972753023689, 521.7495602110932, 540.8269353806822, 565.4430386069718, 586.3169407640137, 8602.95698521516, 9147.725568232963, 9165.762622046072, 9242.676506322381, 9303.302252331103, 503.46632569476475, 525.9691005628933, 542.6852425593147, 572.6220694341714, 599.9520038396918, 3232.8868489603224, 3948.2103579284258, 4063.2889244382113, 4122.237386083524, 4134.565870583606, 78667.42665146665, 89658.55170724104, 90539.54730226306, 90711.0, 91605.083949161, 75384.0, 75604.62197688976, 75630.24369756342, 77590.0, 78122.21877781149, 64913.67543162254, 67305.32694673089, 67611.32388676149, 67720.3227967714, 68237.0, 8799.604017819342, 8857.99047076799, 8871.64513419456, 8874.64501419936, 8959.596818143329, 43874.561254388325, 44292.0, 46794.06411871812, 47050.52949470461, 47600.523994759606, 65246.0, 66465.0, 66838.0, 70234.64882675758, 70705.29294706987, 10725.302855314692, 11005.889941100486, 11218.99029087386, 11382.715432114263, 11738.093116727496, 12128.09039322072, 12152.635420937386, 12309.322987235788, 12335.013198944242, 12415.503379865066, 11583.942080289544, 11586.073114151017, 11621.941890290494, 11659.941700291443, 11798.469068891749, 9929.553170107218, 11262.774744505228, 11356.148288878201, 11814.468348924147, 11874.346910919983, 9256.676016339396, 9512.2865785065, 11214.046806021579, 11556.768864622492, 11559.19085664029, 8467.153284671484, 9325.347225694408, 9407.764805879908, 9428.003391225582, 9700.175485083564, 9296.767580810534, 9313.0, 9722.951385243028, 9795.06946840049, 9811.313208075366], "unit": "score", "name": "yui.html", "value": 6782.765370252829}], "name": "dromaeo_css", "value": 7440.161653144357}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 106.0, 115.0, 114.0, 115.0, 126.0, 115.0, 116.0, 115.0, 116.0], "unit": "score", "name": "ai-astar", "value": 115.4}, {"lowerIsBetter": true, "replicates": [157.0, 149.0, 149.0, 152.0, 120.0, 168.0, 163.0, 123.0, 155.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 145.9}, {"lowerIsBetter": true, "replicates": [198.0, 202.0, 203.0, 199.0, 213.0, 232.0, 256.0, 274.0, 206.0, 197.0], "unit": "score", "name": "audio-dft", "value": 218.0}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 71.0, 113.0, 62.0, 58.0, 65.0, 84.0, 167.0, 57.0], "unit": "score", "name": "audio-fft", "value": 81.6}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 151.0, 114.0, 115.0, 67.0, 137.0, 119.0, 120.0, 150.0], "unit": "score", "name": "audio-oscillator", "value": 113.9}, {"lowerIsBetter": true, "replicates": [87.0, 93.0, 87.0, 94.0, 88.0, 92.0, 86.0, 93.0, 88.0, 92.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 97.0, 119.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 97.9}, {"lowerIsBetter": true, "replicates": [91.0, 94.0, 92.0, 92.0, 93.0, 92.0, 88.0, 96.0, 96.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 92.6}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 56.0, 57.0, 60.0, 57.0, 59.0, 66.0, 66.0, 75.0], "unit": "score", "name": "json-parse-financial", "value": 60.9}, {"lowerIsBetter": true, "replicates": [66.0, 85.0, 106.0, 95.0, 76.0, 71.0, 69.0, 68.0, 69.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 77.2}, {"lowerIsBetter": true, "replicates": [75.0, 106.0, 72.0, 73.0, 108.0, 100.0, 106.0, 109.0, 108.0, 109.0], "unit": "score", "name": "stanford-crypto-aes", "value": 96.6}, {"lowerIsBetter": true, "replicates": [128.0, 130.0, 126.0, 128.0, 126.0, 127.0, 124.0, 122.0, 114.0, 163.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.8}, {"lowerIsBetter": true, "replicates": [131.0, 144.0, 179.0, 137.0, 139.0, 129.0, 141.0, 159.0, 144.0, 129.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.2}, {"lowerIsBetter": true, "replicates": [65.0, 70.0, 65.0, 70.0, 66.0, 68.0, 66.0, 70.0, 67.0, 99.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.6}], "name": "kraken", "value": 1532.5999999999997}]} 03:11:19 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1532.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7440.16"}}} 03:11:19 INFO - Return code: 0 03:11:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:11:19 INFO - # TBPL SUCCESS # 03:11:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:11:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:11:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:11:19 INFO - 2016-02-10 03:11:19.223 screenresolution[2126:16036] starting screenresolution argv=screenresolution get 03:11:19 INFO - 2016-02-10 03:11:19.225 screenresolution[2126:16036] Display 0: 1600x1200x32@60 03:11:19 INFO - 2016-02-10 03:11:19.231 screenresolution[2127:16039] starting screenresolution argv=screenresolution list 03:11:19 INFO - Available Modes on Display 0 03:11:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:11:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:11:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:11:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:11:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:11:19 INFO - Intel Iris: 03:11:19 INFO - Chipset Model: Intel Iris 03:11:19 INFO - Type: GPU 03:11:19 INFO - Bus: Built-In 03:11:19 INFO - VRAM (Dynamic, Max): 1536 MB 03:11:19 INFO - Vendor: Intel (0x8086) 03:11:19 INFO - Device ID: 0x0a2e 03:11:19 INFO - Revision ID: 0x0009 03:11:19 INFO - Displays: 03:11:19 INFO - Display: 03:11:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:11:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:11:19 INFO - Display Serial Number: 1600x1200 60 03:11:19 INFO - Main Display: Yes 03:11:19 INFO - Mirror: Off 03:11:19 INFO - Online: Yes 03:11:19 INFO - Rotation: Supported 03:11:19 INFO - Return code: 0 03:11:19 INFO - Running post-action listener: _resource_record_post_action 03:11:19 INFO - Running post-run listener: _resource_record_post_run 03:11:20 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 31612416; Write bytes: 711393792; Read time: 324; Write time: 2312 03:11:20 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 401424896; Write bytes: 395728384; Read time: 29940; Write time: 724 03:11:20 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 31587840; Write bytes: 302025728; Read time: 323; Write time: 1546 03:11:20 INFO - Running post-run listener: _upload_blobber_files 03:11:20 INFO - Blob upload gear active. 03:11:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:11:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:11:20 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'] 03:11:20 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 03:11:20 INFO - (blobuploader) - INFO - Open directory for files ... 03:11:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:11:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:11:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:11:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:11:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:11:22 INFO - (blobuploader) - INFO - Done attempting. 03:11:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:11:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:11:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:11:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:11:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:11:23 INFO - (blobuploader) - INFO - Done attempting. 03:11:23 INFO - (blobuploader) - INFO - Iteration through files over. 03:11:23 INFO - Return code: 0 03:11:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:11:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:11:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df59081b4f8d9fad5575bb45b9865e2a5d09829bb82fffb834e4cffd770d655a6e0742ed257c328a029fb9f5f7e30d1cadd6d2a7f724976c85829b4bbcd06a88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcdec7a875bc65b3f0c7912db4b9a147e7580fe6d8944b3e11c0352af3af81a93f37ca54f51a7c20f06424b38ea8bdec2122d4411d0c8944d5c8ccefe3ee535a"} 03:11:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:11:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:11:23 INFO - Contents: 03:11:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df59081b4f8d9fad5575bb45b9865e2a5d09829bb82fffb834e4cffd770d655a6e0742ed257c328a029fb9f5f7e30d1cadd6d2a7f724976c85829b4bbcd06a88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcdec7a875bc65b3f0c7912db4b9a147e7580fe6d8944b3e11c0352af3af81a93f37ca54f51a7c20f06424b38ea8bdec2122d4411d0c8944d5c8ccefe3ee535a"} 03:11:23 INFO - Running post-run listener: copy_logs_to_upload_dir 03:11:23 INFO - Copying logs to upload dir... 03:11:23 INFO - mkdir: /builds/slave/test/build/upload/logs 03:11:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.369716 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-02-10 03:11:23.381720) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 03:11:23.384857) ========= 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.Y0wgwYSQiO/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.X1beQl2r6k/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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/df59081b4f8d9fad5575bb45b9865e2a5d09829bb82fffb834e4cffd770d655a6e0742ed257c328a029fb9f5f7e30d1cadd6d2a7f724976c85829b4bbcd06a88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcdec7a875bc65b3f0c7912db4b9a147e7580fe6d8944b3e11c0352af3af81a93f37ca54f51a7c20f06424b38ea8bdec2122d4411d0c8944d5c8ccefe3ee535a"} build_url:https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010864 build_url: 'https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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/df59081b4f8d9fad5575bb45b9865e2a5d09829bb82fffb834e4cffd770d655a6e0742ed257c328a029fb9f5f7e30d1cadd6d2a7f724976c85829b4bbcd06a88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcdec7a875bc65b3f0c7912db4b9a147e7580fe6d8944b3e11c0352af3af81a93f37ca54f51a7c20f06424b38ea8bdec2122d4411d0c8944d5c8ccefe3ee535a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 03:11:23.414772) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 03:11:23.415130) ========= 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.Y0wgwYSQiO/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.X1beQl2r6k/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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.005017 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 03:11:23.464341) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 03:11:23.464711) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 03:11:23.465099) ========= ========= Total master_lag: 0.26 =========