builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0154 starttime: 1456391213.71 results: success (0) buildid: 20160224233426 builduid: 0de19f8d455642d3ba72681b007dc39c revision: 8ce7a3436936ed07c42de816f2a824b98559fb62 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 01:06:53.717257) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 01:06:53.717753) ========= ========= Started set props: basedir (results: 0, elapsed: 27 secs) (at 2016-02-25 01:06:53.718110) ========= 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.w9LTi7Zah1/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.e1L2B5otke/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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.005477 basedir: '/builds/slave/test' ========= master_lag: 27.50 ========= ========= Finished set props: basedir (results: 0, elapsed: 27 secs) (at 2016-02-25 01:07:21.221951) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 21 secs) (at 2016-02-25 01:07:21.222286) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 21 secs) (at 2016-02-25 01:07:42.349020) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-02-25 01:07:42.349405) ========= 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.w9LTi7Zah1/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.e1L2B5otke/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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.006501 ========= master_lag: 3.74 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-02-25 01:07:46.095620) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 01:07:46.095942) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 01:07:46.096299) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-02-25 01:07:46.096570) ========= 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.w9LTi7Zah1/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.e1L2B5otke/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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-25 01:07:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 181M=0s 2016-02-25 01:07:47 (181 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.571737 ========= master_lag: 5.26 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-02-25 01:07:51.928635) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:07:51.928975) ========= 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.w9LTi7Zah1/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.e1L2B5otke/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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.028828 ========= master_lag: 0.36 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:07:52.320851) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-02-25 01:07:52.321195) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8ce7a3436936ed07c42de816f2a824b98559fb62 --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 8ce7a3436936ed07c42de816f2a824b98559fb62 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.w9LTi7Zah1/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.e1L2B5otke/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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-25 01:07:52,676 truncating revision to first 12 chars 2016-02-25 01:07:52,676 Setting DEBUG logging. 2016-02-25 01:07:52,676 attempt 1/10 2016-02-25 01:07:52,676 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8ce7a3436936?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-25 01:07:52,952 unpacking tar archive at: fx-team-8ce7a3436936/testing/mozharness/ program finished with exit code 0 elapsedTime=0.526326 ========= master_lag: 5.24 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-02-25 01:07:58.083478) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 01:07:58.083889) ========= echo 8ce7a3436936ed07c42de816f2a824b98559fb62 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8ce7a3436936ed07c42de816f2a824b98559fb62'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.w9LTi7Zah1/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.e1L2B5otke/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 8ce7a3436936ed07c42de816f2a824b98559fb62 program finished with exit code 0 elapsedTime=0.005820 script_repo_revision: '8ce7a3436936ed07c42de816f2a824b98559fb62' ========= master_lag: 0.12 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 01:07:58.207417) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-02-25 01:07:58.207771) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-02-25 01:07:59.801654) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-02-25 01:07:59.802029) ========= /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.w9LTi7Zah1/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.e1L2B5otke/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 01:07:59 INFO - MultiFileLogger online at 20160225 01:07:59 in /builds/slave/test 01:07:59 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 01:07:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:07:59 INFO - {'append_to_log': False, 01:07:59 INFO - 'base_work_dir': '/builds/slave/test', 01:07:59 INFO - 'blob_upload_branch': 'Fx-Team', 01:07:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:07:59 INFO - 'branch': 'Fx-Team', 01:07:59 INFO - 'buildbot_json_path': 'buildprops.json', 01:07:59 INFO - 'config_files': ('talos/mac_config.py',), 01:07:59 INFO - 'default_actions': ('clobber', 01:07:59 INFO - 'read-buildbot-config', 01:07:59 INFO - 'download-and-extract', 01:07:59 INFO - 'populate-webroot', 01:07:59 INFO - 'create-virtualenv', 01:07:59 INFO - 'install', 01:07:59 INFO - 'run-tests'), 01:07:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:07:59 INFO - 'download_minidump_stackwalk': True, 01:07:59 INFO - 'download_symbols': 'ondemand', 01:07:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:07:59 INFO - 'tooltool.py': '/tools/tooltool.py', 01:07:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:07:59 INFO - '/tools/misc-python/virtualenv.py')}, 01:07:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:07:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:07:59 INFO - 'installer_path': 'installer.exe', 01:07:59 INFO - 'log_level': 'info', 01:07:59 INFO - 'log_name': 'talos', 01:07:59 INFO - 'log_to_console': True, 01:07:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:07:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:07:59 INFO - 'opt_config_files': (), 01:07:59 INFO - 'pip_index': False, 01:07:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:07:59 INFO - 'cmd': ('bash', 01:07:59 INFO - '-c', 01:07:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:07:59 INFO - 'enabled': True, 01:07:59 INFO - 'halt_on_failure': False, 01:07:59 INFO - 'name': 'check_screen_resolution'},), 01:07:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:07:59 INFO - 'cmd': ('bash', 01:07:59 INFO - '-c', 01:07:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:07:59 INFO - 'enabled': True, 01:07:59 INFO - 'halt_on_failure': False, 01:07:59 INFO - 'name': 'check_screen_resolution'},), 01:07:59 INFO - 'run_cmd_checks_enabled': True, 01:07:59 INFO - 'sps_profile': False, 01:07:59 INFO - 'sps_profile_interval': 0, 01:07:59 INFO - 'suite': 'dromaeojs-e10s', 01:07:59 INFO - 'system_bits': '32', 01:07:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:07:59 INFO - 'title': 't-yosemite-r7-0154', 01:07:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:07:59 INFO - 'use_talos_json': True, 01:08:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:08:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:08:00 INFO - 'work_dir': 'build'} 01:08:00 INFO - ##### 01:08:00 INFO - ##### Running clobber step. 01:08:00 INFO - ##### 01:08:00 INFO - Running pre-action listener: _resource_record_pre_action 01:08:00 INFO - Running main action method: clobber 01:08:00 INFO - rmtree: /builds/slave/test/build 01:08:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:08:01 INFO - Running post-action listener: _resource_record_post_action 01:08:01 INFO - ##### 01:08:01 INFO - ##### Running read-buildbot-config step. 01:08:01 INFO - ##### 01:08:01 INFO - Running pre-action listener: _resource_record_pre_action 01:08:01 INFO - Running main action method: read_buildbot_config 01:08:01 INFO - Using buildbot properties: 01:08:01 INFO - { 01:08:01 INFO - "project": "", 01:08:01 INFO - "product": "firefox", 01:08:01 INFO - "script_repo_revision": "production", 01:08:01 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 01:08:01 INFO - "repository": "", 01:08:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 01:08:01 INFO - "buildid": "20160224233426", 01:08:01 INFO - "pgo_build": "False", 01:08:01 INFO - "basedir": "/builds/slave/test", 01:08:01 INFO - "buildnumber": 448, 01:08:01 INFO - "slavename": "t-yosemite-r7-0154", 01:08:01 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 01:08:01 INFO - "platform": "yosemite_r7", 01:08:01 INFO - "scheduler": "tests-fx-team-macosx64-talos", 01:08:01 INFO - "branch": "fx-team", 01:08:01 INFO - "repo_path": "integration/fx-team", 01:08:01 INFO - "revision": "8ce7a3436936ed07c42de816f2a824b98559fb62", 01:08:01 INFO - "stage_platform": "macosx64", 01:08:01 INFO - "builduid": "0de19f8d455642d3ba72681b007dc39c", 01:08:01 INFO - "slavebuilddir": "test" 01:08:01 INFO - } 01:08:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 01:08:01 INFO - Running post-action listener: _resource_record_post_action 01:08:01 INFO - ##### 01:08:01 INFO - ##### Running download-and-extract step. 01:08:01 INFO - ##### 01:08:01 INFO - Running pre-action listener: _resource_record_pre_action 01:08:01 INFO - Running main action method: download_and_extract 01:08:01 INFO - mkdir: /builds/slave/test/build/tests 01:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:01 INFO - https://queue.taskcluster.net/v1/task/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:08:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/test_packages.json 01:08:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/test_packages.json 01:08:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 01:08:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 01:08:02 INFO - Downloaded 1277 bytes. 01:08:02 INFO - Reading from file /builds/slave/test/build/test_packages.json 01:08:02 INFO - Using the following test package requirements: 01:08:02 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:08:02 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:08:02 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 01:08:02 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:08:02 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 01:08:02 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:08:02 INFO - u'jsshell-mac.zip'], 01:08:02 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:08:02 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 01:08:02 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:08:02 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:08:02 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 01:08:02 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:08:02 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 01:08:02 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:08:02 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 01:08:02 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:08:02 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:08:02 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 01:08:02 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:02 INFO - https://queue.taskcluster.net/v1/task/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:08:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:08:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:08:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpvVPTkXQRupUvVME-NKRA/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 01:08:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpvVPTkXQRupUvVME-NKRA/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 01:08:04 INFO - Downloaded 17828704 bytes. 01:08:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:08:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:08:07 INFO - Return code: 0 01:08:07 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 01:08:07 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')]} 01:08:07 INFO - https://queue.taskcluster.net/v1/task/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:08:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:08:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:08:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpvVPTkXQRupUvVME-NKRA/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 01:08:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpvVPTkXQRupUvVME-NKRA/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 01:08:08 INFO - Downloaded 17828704 bytes. 01:08:08 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'] 01:08:08 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 01:08:11 INFO - Return code: 0 01:08:11 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')]} 01:08:11 INFO - https://queue.taskcluster.net/v1/task/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:08:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:08:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:08:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpvVPTkXQRupUvVME-NKRA/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 01:08:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpvVPTkXQRupUvVME-NKRA/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 01:08:12 INFO - Downloaded 10707015 bytes. 01:08:12 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'] 01:08:12 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 01:08:12 INFO - Return code: 0 01:08:12 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')]} 01:08:12 INFO - https://queue.taskcluster.net/v1/task/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:08:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:08:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:08:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 01:08:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpvVPTkXQRupUvVME-NKRA/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 01:08:15 INFO - Downloaded 111445828 bytes. 01:08:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:08:15 INFO - mkdir: /builds/slave/test/properties 01:08:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:08:15 INFO - Writing to file /builds/slave/test/properties/build_url 01:08:15 INFO - Contents: 01:08:15 INFO - build_url:https://queue.taskcluster.net/v1/task/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:08:16 INFO - Running post-action listener: _resource_record_post_action 01:08:16 INFO - Running post-action listener: set_extra_try_arguments 01:08:16 INFO - ##### 01:08:16 INFO - ##### Running populate-webroot step. 01:08:16 INFO - ##### 01:08:16 INFO - Running pre-action listener: _resource_record_pre_action 01:08:16 INFO - Running main action method: populate_webroot 01:08:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:08:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:08:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:08:16 INFO - '--tppagecycles', 01:08:16 INFO - '7'], 01:08:16 INFO - 'tests': ['tsvgm']}}, 01:08:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:08:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:08:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:08:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:08:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:08:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:08:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:08:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:16 INFO - 'talos_options': ['--e10s'], 01:08:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:08:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:16 INFO - 'tests': ['damp', 'tps']}, 01:08:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:16 INFO - 'talos_options': ['--e10s'], 01:08:16 INFO - 'tests': ['damp', 'tps']}, 01:08:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:08:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:08:16 INFO - 'other': {'tests': ['a11yr', 01:08:16 INFO - 'ts_paint', 01:08:16 INFO - 'tpaint', 01:08:16 INFO - 'sessionrestore', 01:08:16 INFO - 'sessionrestore_no_auto_restore']}, 01:08:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:08:16 INFO - 'tests': ['a11yr', 01:08:16 INFO - 'ts_paint', 01:08:16 INFO - 'tpaint', 01:08:16 INFO - 'sessionrestore', 01:08:16 INFO - 'sessionrestore_no_auto_restore']}, 01:08:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:08:16 INFO - 'tests': ['a11yr', 01:08:16 INFO - 'ts_paint', 01:08:16 INFO - 'tpaint', 01:08:16 INFO - 'sessionrestore', 01:08:16 INFO - 'sessionrestore_no_auto_restore']}, 01:08:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:08:16 INFO - 'tests': ['a11yr', 01:08:16 INFO - 'ts_paint', 01:08:16 INFO - 'tpaint', 01:08:16 INFO - 'sessionrestore', 01:08:16 INFO - 'sessionrestore_no_auto_restore']}, 01:08:16 INFO - 'other_l64': {'tests': ['a11yr', 01:08:16 INFO - 'ts_paint', 01:08:16 INFO - 'tpaint', 01:08:16 INFO - 'sessionrestore', 01:08:16 INFO - 'sessionrestore_no_auto_restore']}, 01:08:16 INFO - 'other_nol64': {'tests': ['a11yr', 01:08:16 INFO - 'ts_paint', 01:08:16 INFO - 'tpaint', 01:08:16 INFO - 'sessionrestore', 01:08:16 INFO - 'sessionrestore_no_auto_restore']}, 01:08:16 INFO - 'svgr': {'tests': ['tsvgx', 01:08:16 INFO - 'tsvgr_opacity', 01:08:16 INFO - 'tart', 01:08:16 INFO - 'tscrollx', 01:08:16 INFO - 'cart']}, 01:08:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:08:16 INFO - 'tests': ['tsvgx', 01:08:16 INFO - 'tsvgr_opacity', 01:08:16 INFO - 'tart', 01:08:16 INFO - 'tscrollx', 01:08:16 INFO - 'cart']}, 01:08:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:16 INFO - 'tests': ['tp5o']}, 01:08:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:16 INFO - 'talos_options': ['--e10s'], 01:08:16 INFO - 'tests': ['tp5o']}, 01:08:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:16 INFO - 'talos_options': ['--xperf_path', 01:08:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:08:16 INFO - 'tests': ['tp5n']}, 01:08:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:16 INFO - 'talos_options': ['--e10s', 01:08:16 INFO - '--xperf_path', 01:08:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:08:16 INFO - 'tests': ['tp5n']}}, 01:08:16 INFO - 'talos.zip': {'path': '', 01:08:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:08:16 INFO - Running post-action listener: _resource_record_post_action 01:08:16 INFO - ##### 01:08:16 INFO - ##### Running create-virtualenv step. 01:08:16 INFO - ##### 01:08:16 INFO - Running pre-action listener: _resource_record_pre_action 01:08:16 INFO - Running main action method: create_virtualenv 01:08:16 INFO - Creating virtualenv /builds/slave/test/build/venv 01:08:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:08:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:08:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:08:17 INFO - Using real prefix '/tools/python27' 01:08:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:08:17 INFO - Installing distribute.............................................................................................................................................................................................done. 01:08:20 INFO - Installing pip.................done. 01:08:20 INFO - Return code: 0 01:08:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aec3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcbbd7d470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad67d30>, '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 0x10ab8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad5eb20>, '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.w9LTi7Zah1/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.e1L2B5otke/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 01:08:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:08:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:08:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w9LTi7Zah1/Render', 01:08:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:08:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:08:20 INFO - 'HOME': '/Users/cltbld', 01:08:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:08:20 INFO - 'LOGNAME': 'cltbld', 01:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:20 INFO - 'MOZ_NO_REMOTE': '1', 01:08:20 INFO - 'NO_EM_RESTART': '1', 01:08:20 INFO - 'PAGER': '/bin/cat', 01:08:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:20 INFO - 'PWD': '/builds/slave/test', 01:08:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:08:20 INFO - 'SHELL': '/bin/bash', 01:08:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e1L2B5otke/Listeners', 01:08:20 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 01:08:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:08:20 INFO - 'USER': 'cltbld', 01:08:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:08:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:20 INFO - 'XPC_FLAGS': '0x0', 01:08:20 INFO - 'XPC_SERVICE_NAME': '0', 01:08:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:08:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:08:20 INFO - Cleaning up... 01:08:20 INFO - Return code: 0 01:08:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aec3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcbbd7d470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad67d30>, '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 0x10ab8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad5eb20>, '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.w9LTi7Zah1/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.e1L2B5otke/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 01:08:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:08:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:08:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w9LTi7Zah1/Render', 01:08:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:08:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:08:20 INFO - 'HOME': '/Users/cltbld', 01:08:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:08:20 INFO - 'LOGNAME': 'cltbld', 01:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:20 INFO - 'MOZ_NO_REMOTE': '1', 01:08:20 INFO - 'NO_EM_RESTART': '1', 01:08:20 INFO - 'PAGER': '/bin/cat', 01:08:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:20 INFO - 'PWD': '/builds/slave/test', 01:08:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:08:20 INFO - 'SHELL': '/bin/bash', 01:08:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e1L2B5otke/Listeners', 01:08:20 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 01:08:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:08:20 INFO - 'USER': 'cltbld', 01:08:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:08:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:20 INFO - 'XPC_FLAGS': '0x0', 01:08:20 INFO - 'XPC_SERVICE_NAME': '0', 01:08:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:08:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:21 INFO - Downloading/unpacking psutil>=0.7.1 01:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:08:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:08:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:08:24 INFO - Installing collected packages: psutil 01:08:24 INFO - Running setup.py install for psutil 01:08:24 INFO - building 'psutil._psutil_osx' extension 01:08:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 01:08:25 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 01:08:25 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 01:08:25 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 01:08:25 INFO - building 'psutil._psutil_posix' extension 01:08:25 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 01:08:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:08:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:08:25 INFO - ^ 01:08:25 INFO - 1 warning generated. 01:08:25 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 01:08:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:08:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:08:25 INFO - Successfully installed psutil 01:08:25 INFO - Cleaning up... 01:08:25 INFO - Return code: 0 01:08:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:08: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')]} 01:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08: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')]} 01:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:25 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 0x10aec3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcbbd7d470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad67d30>, '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 0x10ab8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad5eb20>, '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.w9LTi7Zah1/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.e1L2B5otke/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 01:08:25 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 01:08:25 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 01:08:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w9LTi7Zah1/Render', 01:08:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:08:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:08:25 INFO - 'HOME': '/Users/cltbld', 01:08:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:08:25 INFO - 'LOGNAME': 'cltbld', 01:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:25 INFO - 'MOZ_NO_REMOTE': '1', 01:08:25 INFO - 'NO_EM_RESTART': '1', 01:08:25 INFO - 'PAGER': '/bin/cat', 01:08:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:25 INFO - 'PWD': '/builds/slave/test', 01:08:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:08:25 INFO - 'SHELL': '/bin/bash', 01:08:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e1L2B5otke/Listeners', 01:08:25 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 01:08:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:08:25 INFO - 'USER': 'cltbld', 01:08:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:08:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:25 INFO - 'XPC_FLAGS': '0x0', 01:08:25 INFO - 'XPC_SERVICE_NAME': '0', 01:08:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:08:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:08:28 INFO - Installing collected packages: mozsystemmonitor 01:08:28 INFO - Running setup.py install for mozsystemmonitor 01:08:28 INFO - Successfully installed mozsystemmonitor 01:08:28 INFO - Cleaning up... 01:08:28 INFO - Return code: 0 01:08:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:08:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aec3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcbbd7d470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad67d30>, '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 0x10ab8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad5eb20>, '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.w9LTi7Zah1/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.e1L2B5otke/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 01:08:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:08:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w9LTi7Zah1/Render', 01:08:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:08:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:08:28 INFO - 'HOME': '/Users/cltbld', 01:08:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:08:28 INFO - 'LOGNAME': 'cltbld', 01:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:28 INFO - 'MOZ_NO_REMOTE': '1', 01:08:28 INFO - 'NO_EM_RESTART': '1', 01:08:28 INFO - 'PAGER': '/bin/cat', 01:08:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:28 INFO - 'PWD': '/builds/slave/test', 01:08:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:08:28 INFO - 'SHELL': '/bin/bash', 01:08:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e1L2B5otke/Listeners', 01:08:28 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 01:08:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:08:28 INFO - 'USER': 'cltbld', 01:08:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:08:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:28 INFO - 'XPC_FLAGS': '0x0', 01:08:28 INFO - 'XPC_SERVICE_NAME': '0', 01:08:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:08:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:28 INFO - Downloading/unpacking blobuploader==1.2.4 01:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:31 INFO - Downloading blobuploader-1.2.4.tar.gz 01:08:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:08:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:08:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:32 INFO - Downloading docopt-0.6.1.tar.gz 01:08:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:08:32 INFO - Installing collected packages: blobuploader, requests, docopt 01:08:32 INFO - Running setup.py install for blobuploader 01:08:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:08:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:08:32 INFO - Running setup.py install for requests 01:08:33 INFO - Running setup.py install for docopt 01:08:33 INFO - Successfully installed blobuploader requests docopt 01:08:33 INFO - Cleaning up... 01:08:33 INFO - Return code: 0 01:08:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:33 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 0x10aec3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcbbd7d470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad67d30>, '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 0x10ab8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad5eb20>, '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.w9LTi7Zah1/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.e1L2B5otke/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 01:08:33 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 01:08:33 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 01:08:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w9LTi7Zah1/Render', 01:08:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:08:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:08:33 INFO - 'HOME': '/Users/cltbld', 01:08:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:08:33 INFO - 'LOGNAME': 'cltbld', 01:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:33 INFO - 'MOZ_NO_REMOTE': '1', 01:08:33 INFO - 'NO_EM_RESTART': '1', 01:08:33 INFO - 'PAGER': '/bin/cat', 01:08:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:33 INFO - 'PWD': '/builds/slave/test', 01:08:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:08:33 INFO - 'SHELL': '/bin/bash', 01:08:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e1L2B5otke/Listeners', 01:08:33 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 01:08:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:08:33 INFO - 'USER': 'cltbld', 01:08:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:08:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:33 INFO - 'XPC_FLAGS': '0x0', 01:08:33 INFO - 'XPC_SERVICE_NAME': '0', 01:08:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:08:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:08:33 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-Bn1MnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:08:33 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-YRNRqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:08:33 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-CTeITC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:08:33 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-PNIDBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:08:33 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-xxQjEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:08:34 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-JppIVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:08:34 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-D3H9Og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:08:34 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-AJyy2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:08:34 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-wD87Wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:08:34 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-RtR9SV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:08:34 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-lHJq3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:08:34 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-WL1auR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:08:34 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-euc_9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:08:34 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-77ZPz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:08:34 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-z0K6Br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:08:35 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-aFP7IY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:08:35 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-_5s5_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:08:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:08:35 INFO - Running setup.py install for manifestparser 01:08:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:08:35 INFO - Running setup.py install for mozcrash 01:08:35 INFO - Running setup.py install for mozdebug 01:08:35 INFO - Running setup.py install for mozdevice 01:08:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:08:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:08:35 INFO - Running setup.py install for mozfile 01:08:36 INFO - Running setup.py install for mozhttpd 01:08:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:08:36 INFO - Running setup.py install for mozinfo 01:08:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:08:36 INFO - Running setup.py install for mozInstall 01:08:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:08:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:08:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:08:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:08:36 INFO - Running setup.py install for mozleak 01:08:36 INFO - Running setup.py install for mozlog 01:08:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:08:36 INFO - Running setup.py install for moznetwork 01:08:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:08:36 INFO - Running setup.py install for mozprocess 01:08:37 INFO - Running setup.py install for mozprofile 01:08:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:08:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:08:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:08:37 INFO - Running setup.py install for mozrunner 01:08:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:08:37 INFO - Running setup.py install for mozscreenshot 01:08:37 INFO - Running setup.py install for moztest 01:08:37 INFO - Running setup.py install for mozversion 01:08:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:08:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:08:37 INFO - Cleaning up... 01:08:37 INFO - Return code: 0 01:08:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aec3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcbbd7d470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad67d30>, '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 0x10ab8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad5eb20>, '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.w9LTi7Zah1/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.e1L2B5otke/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 01:08:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:08:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:08:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w9LTi7Zah1/Render', 01:08:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:08:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:08:37 INFO - 'HOME': '/Users/cltbld', 01:08:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:08:37 INFO - 'LOGNAME': 'cltbld', 01:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:37 INFO - 'MOZ_NO_REMOTE': '1', 01:08:37 INFO - 'NO_EM_RESTART': '1', 01:08:37 INFO - 'PAGER': '/bin/cat', 01:08:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:37 INFO - 'PWD': '/builds/slave/test', 01:08:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:08:37 INFO - 'SHELL': '/bin/bash', 01:08:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e1L2B5otke/Listeners', 01:08:37 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 01:08:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:08:37 INFO - 'USER': 'cltbld', 01:08:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:08:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:37 INFO - 'XPC_FLAGS': '0x0', 01:08:37 INFO - 'XPC_SERVICE_NAME': '0', 01:08:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:08:38 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-Jvqu7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:08:38 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)) 01:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:08:38 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-C_Q8ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:08:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:08:38 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-yEfSDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:08:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:08:38 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-PX9Luw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:08:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:08:38 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-mJ3sbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:08:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:08:38 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-CXdq_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:08:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:08:38 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-9t33y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:08:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:08:38 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-oPBTt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:08:39 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)) 01:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:08:39 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-84jwrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:08:39 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)) 01:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:08:39 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-PG2yA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:08:39 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)) 01:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:08:39 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-fIA0Ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:08:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:08:39 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-iyHsEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:08:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:08:39 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-CKkzcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:08:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:08:39 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-oGwSn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:08:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:08:39 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-ej2lzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:08:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:08:39 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-_ECgFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:08:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:08:39 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-Tx_zNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:08:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:08:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:08:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:08:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:08:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:08:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:08:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:42 INFO - Downloading blessings-1.6.tar.gz 01:08:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:08:42 INFO - Installing collected packages: blessings 01:08:42 INFO - Running setup.py install for blessings 01:08:42 INFO - Successfully installed blessings 01:08:42 INFO - Cleaning up... 01:08:42 INFO - Return code: 0 01:08:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:08:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:08:42 INFO - Reading from file tmpfile_stdout 01:08:42 INFO - Current package versions: 01:08:42 INFO - blessings == 1.6 01:08:42 INFO - blobuploader == 1.2.4 01:08:42 INFO - docopt == 0.6.1 01:08:42 INFO - manifestparser == 1.1 01:08:42 INFO - mozInstall == 1.12 01:08:42 INFO - mozcrash == 0.16 01:08:42 INFO - mozdebug == 0.1 01:08:42 INFO - mozdevice == 0.48 01:08:42 INFO - mozfile == 1.2 01:08:42 INFO - mozhttpd == 0.7 01:08:42 INFO - mozinfo == 0.9 01:08:42 INFO - mozleak == 0.1 01:08:42 INFO - mozlog == 3.1 01:08:42 INFO - moznetwork == 0.27 01:08:42 INFO - mozprocess == 0.22 01:08:42 INFO - mozprofile == 0.28 01:08:42 INFO - mozrunner == 6.11 01:08:42 INFO - mozscreenshot == 0.1 01:08:42 INFO - mozsystemmonitor == 0.0 01:08:42 INFO - moztest == 0.7 01:08:42 INFO - mozversion == 1.4 01:08:42 INFO - psutil == 3.1.1 01:08:42 INFO - requests == 1.2.3 01:08:42 INFO - wsgiref == 0.1.2 01:08:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aec3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcbbd7d470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad67d30>, '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 0x10ab8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad5eb20>, '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.w9LTi7Zah1/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.e1L2B5otke/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 01:08:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:08:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w9LTi7Zah1/Render', 01:08:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:08:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:08:42 INFO - 'HOME': '/Users/cltbld', 01:08:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:08:42 INFO - 'LOGNAME': 'cltbld', 01:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:42 INFO - 'MOZ_NO_REMOTE': '1', 01:08:42 INFO - 'NO_EM_RESTART': '1', 01:08:42 INFO - 'PAGER': '/bin/cat', 01:08:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:42 INFO - 'PWD': '/builds/slave/test', 01:08:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:08:42 INFO - 'SHELL': '/bin/bash', 01:08:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e1L2B5otke/Listeners', 01:08:42 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 01:08:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:08:42 INFO - 'USER': 'cltbld', 01:08:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:08:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:42 INFO - 'XPC_FLAGS': '0x0', 01:08:42 INFO - 'XPC_SERVICE_NAME': '0', 01:08:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:43 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)) 01:08:43 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)) 01:08:43 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)) 01:08:43 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)) 01:08:43 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)) 01:08:43 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)) 01:08:43 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)) 01:08:43 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)) 01:08:43 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)) 01:08:43 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)) 01:08:43 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)) 01:08:43 INFO - Cleaning up... 01:08:43 INFO - Return code: 0 01:08:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aec3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcbbd7d470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad67d30>, '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 0x10ab8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad5eb20>, '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.w9LTi7Zah1/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.e1L2B5otke/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 01:08:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:08:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w9LTi7Zah1/Render', 01:08:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:08:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:08:43 INFO - 'HOME': '/Users/cltbld', 01:08:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:08:43 INFO - 'LOGNAME': 'cltbld', 01:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:43 INFO - 'MOZ_NO_REMOTE': '1', 01:08:43 INFO - 'NO_EM_RESTART': '1', 01:08:43 INFO - 'PAGER': '/bin/cat', 01:08:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:43 INFO - 'PWD': '/builds/slave/test', 01:08:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:08:43 INFO - 'SHELL': '/bin/bash', 01:08:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e1L2B5otke/Listeners', 01:08:43 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 01:08:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:08:43 INFO - 'USER': 'cltbld', 01:08:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:08:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:43 INFO - 'XPC_FLAGS': '0x0', 01:08:43 INFO - 'XPC_SERVICE_NAME': '0', 01:08:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:43 INFO - Downloading/unpacking jsonschema 01:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:08:45 INFO - Downloading/unpacking functools32 (from jsonschema) 01:08: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 01:08: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 01:08: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 01:08: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 01:08: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 01:08: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 01:08:46 INFO - Downloading functools32-3.2.3-2.tar.gz 01:08:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:08:46 INFO - warning: no files found matching '*.txt' 01:08:46 INFO - no previously-included directories found matching 'build' 01:08:46 INFO - no previously-included directories found matching 'dist' 01:08:46 INFO - no previously-included directories found matching '.git*' 01:08:46 INFO - Installing collected packages: jsonschema, functools32 01:08:46 INFO - Running setup.py install for functools32 01:08:46 INFO - warning: no files found matching '*.txt' 01:08:46 INFO - no previously-included directories found matching 'build' 01:08:46 INFO - no previously-included directories found matching 'dist' 01:08:46 INFO - no previously-included directories found matching '.git*' 01:08:46 INFO - Successfully installed jsonschema functools32 01:08:46 INFO - Cleaning up... 01:08:46 INFO - Return code: 0 01:08:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aec3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcbbd7d470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad67d30>, '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 0x10ab8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad5eb20>, '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.w9LTi7Zah1/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.e1L2B5otke/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 01:08:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:08:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:08:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w9LTi7Zah1/Render', 01:08:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:08:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:08:46 INFO - 'HOME': '/Users/cltbld', 01:08:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:08:46 INFO - 'LOGNAME': 'cltbld', 01:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:46 INFO - 'MOZ_NO_REMOTE': '1', 01:08:46 INFO - 'NO_EM_RESTART': '1', 01:08:46 INFO - 'PAGER': '/bin/cat', 01:08:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:08:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:46 INFO - 'PWD': '/builds/slave/test', 01:08:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:08:46 INFO - 'SHELL': '/bin/bash', 01:08:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e1L2B5otke/Listeners', 01:08:46 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 01:08:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:08:46 INFO - 'USER': 'cltbld', 01:08:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:08:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:08:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:46 INFO - 'XPC_FLAGS': '0x0', 01:08:46 INFO - 'XPC_SERVICE_NAME': '0', 01:08:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:46 INFO - Downloading/unpacking flake8 01:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:08:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:08: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 01:08: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 01:08: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 01:08: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 01:08: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 01:08: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 01:08:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:08:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:08: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 01:08: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 01:08: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 01:08: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 01:08: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 01:08: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 01:08:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:08: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 01:08: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 01:08: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 01:08: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 01:08: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 01:08: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 01:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:08:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:08:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:08:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:08:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:08:50 INFO - no previously-included directories found matching 'docs/_build' 01:08:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:08:50 INFO - Running setup.py install for pep8 01:08:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:08:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:08:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:08:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:08:50 INFO - no previously-included directories found matching 'docs/_build' 01:08:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:08:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:08:50 INFO - Cleaning up... 01:08:50 INFO - Return code: 0 01:08:50 INFO - Running post-action listener: _resource_record_post_action 01:08:50 INFO - Running post-action listener: _start_resource_monitoring 01:08:50 INFO - Starting resource monitoring. 01:08:50 INFO - ##### 01:08:50 INFO - ##### Running install step. 01:08:50 INFO - ##### 01:08:50 INFO - Running pre-action listener: _resource_record_pre_action 01:08:50 INFO - Running main action method: install 01:08:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:08:51 INFO - Reading from file tmpfile_stdout 01:08:51 INFO - Detecting whether we're running mozinstall >=1.0... 01:08:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:08:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:08:51 INFO - Reading from file tmpfile_stdout 01:08:51 INFO - Output received: 01:08:51 INFO - Usage: mozinstall [options] installer 01:08:51 INFO - Options: 01:08:51 INFO - -h, --help show this help message and exit 01:08:51 INFO - -d DEST, --destination=DEST 01:08:51 INFO - Directory to install application into. [default: 01:08:51 INFO - "/builds/slave/test"] 01:08:51 INFO - --app=APP Application being installed. [default: firefox] 01:08:51 INFO - mkdir: /builds/slave/test/build/application 01:08:51 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'] 01:08:51 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 01:09:25 INFO - Reading from file tmpfile_stdout 01:09:25 INFO - Output received: 01:09:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:09:25 INFO - Running post-action listener: _resource_record_post_action 01:09:25 INFO - ##### 01:09:25 INFO - ##### Running run-tests step. 01:09:25 INFO - ##### 01:09:25 INFO - Running pre-action listener: _resource_record_pre_action 01:09:25 INFO - Running main action method: run_tests 01:09:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:09:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:09:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:09:25 INFO - 2016-02-25 01:09:25.475 screenresolution[1656:7974] starting screenresolution argv=screenresolution get 01:09:25 INFO - 2016-02-25 01:09:25.477 screenresolution[1656:7974] Display 0: 1600x1200x32@60 01:09:25 INFO - 2016-02-25 01:09:25.483 screenresolution[1657:7976] starting screenresolution argv=screenresolution list 01:09:25 INFO - Available Modes on Display 0 01:09:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:09:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:09:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:09:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:09:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:09:25 INFO - Intel Iris: 01:09:25 INFO - Chipset Model: Intel Iris 01:09:25 INFO - Type: GPU 01:09:25 INFO - Bus: Built-In 01:09:25 INFO - VRAM (Dynamic, Max): 1536 MB 01:09:25 INFO - Vendor: Intel (0x8086) 01:09:25 INFO - Device ID: 0x0a2e 01:09:25 INFO - Revision ID: 0x0009 01:09:25 INFO - Displays: 01:09:25 INFO - Display: 01:09:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:09:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:09:25 INFO - Display Serial Number: 1600x1200 60 01:09:25 INFO - Main Display: Yes 01:09:25 INFO - Mirror: Off 01:09:25 INFO - Online: Yes 01:09:25 INFO - Rotation: Supported 01:09:25 INFO - Return code: 0 01:09:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:09:25 INFO - Python 2.7.3 01:09:25 INFO - Return code: 0 01:09:25 INFO - grabbing minidump binary from tooltool 01:09: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')]} 01:09:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad67d30>, '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 0x10ab8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad5eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:09:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:09:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 01:09:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:09:25 INFO - Return code: 0 01:09:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:09:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:09:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:09:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:09:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:09:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:09:27 INFO - Return code: 0 01:09:27 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/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0154', '--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 01:09:27 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/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0154 --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 01:09:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w9LTi7Zah1/Render', 01:09:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:09:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:09:27 INFO - 'HOME': '/Users/cltbld', 01:09:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:09:27 INFO - 'LOGNAME': 'cltbld', 01:09:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:09:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:27 INFO - 'MOZ_NO_REMOTE': '1', 01:09:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:09:27 INFO - 'NO_EM_RESTART': '1', 01:09:27 INFO - 'PAGER': '/bin/cat', 01:09:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:27 INFO - 'PWD': '/builds/slave/test', 01:09:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:09:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:09:27 INFO - 'SHELL': '/bin/bash', 01:09:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e1L2B5otke/Listeners', 01:09:27 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 01:09:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:09:27 INFO - 'USER': 'cltbld', 01:09:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:09:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:27 INFO - 'XPC_FLAGS': '0x0', 01:09:27 INFO - 'XPC_SERVICE_NAME': '0', 01:09:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:09:27 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/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0154', '--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 01:09:27 INFO - mozversion application_buildid: 20160224233426 01:09:27 INFO - mozversion application_changeset: 8ce7a3436936ed07c42de816f2a824b98559fb62 01:09:27 INFO - mozversion application_display_name: Nightly 01:09:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:09:27 INFO - mozversion application_name: Firefox 01:09:27 INFO - mozversion application_remotingname: firefox 01:09:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:09:27 INFO - mozversion application_vendor: Mozilla 01:09:27 INFO - mozversion application_version: 47.0a1 01:09:27 INFO - mozversion platform_buildid: 20160224233426 01:09:27 INFO - mozversion platform_changeset: 8ce7a3436936ed07c42de816f2a824b98559fb62 01:09:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:09:27 INFO - mozversion platform_version: 47.0a1 01:09:27 INFO - using testdate: 1456391367 01:09:27 INFO - actual date: 1456391367 01:09:27 INFO - starting webserver on 'localhost:49274' 01:09:27 INFO - SUITE-START | Running 2 tests 01:09:27 INFO - TEST-START | dromaeo_css 01:09:27 INFO - operating with platform_type : mac_ 01:09:27 INFO - Initialising browser for dromaeo_css test... 01:09:27 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmpHNOjsU/profile http://localhost:49274/getInfo.html) 01:09:30 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 01:09:30 INFO - PROCESS | 1675 | colorDepth:24 01:09:30 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 01:09:30 INFO - PROCESS | 1675 | __metrics 01:09:30 ERROR - PROCESS | 1675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 01:09:30 INFO - TEST-INFO | 1675: exit 0 01:09:30 INFO - Browser initialized. 01:09:30 INFO - Running cycle 1/1 for dromaeo_css test... 01:09:30 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmpHNOjsU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:09:42 INFO - PROCESS | 1680 | RSS: Main: 255934464 01:09:42 INFO - PROCESS | 1680 | 01:10:32 INFO - PROCESS | 1680 | 1456391432571 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] 01:12:42 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 01:12:44 INFO - PROCESS | 1680 | RSS: Main: 269127680 01:12:44 INFO - PROCESS | 1680 | 01:15:46 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 01:15:46 INFO - PROCESS | 1680 | RSS: Main: 281796608 01:15:46 INFO - PROCESS | 1680 | 01:18:48 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 01:18:49 INFO - PROCESS | 1680 | RSS: Main: 282533888 01:18:49 INFO - PROCESS | 1680 | 01:21:50 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 01:21:51 INFO - PROCESS | 1680 | RSS: Main: 285421568 01:21:51 INFO - PROCESS | 1680 | 01:24:53 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 01:24:54 INFO - PROCESS | 1680 | RSS: Main: 287944704 01:24:54 INFO - PROCESS | 1680 | 01:27:56 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 01:27:57 INFO - PROCESS | 1680 | RSS: Main: 287784960 01:27:57 INFO - PROCESS | 1680 | 01:27:57 INFO - PROCESS | 1680 | __start_tp_report 01:27:57 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 01:27:57 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 01:27:57 INFO - PROCESS | 1680 | |i|pagename|runs| 01:27:57 INFO - PROCESS | 1680 | |0;dojo.html;3522.841472133754;3563.198280386912;3585.0858031202038;3619.203775169462;3621.2214373909605;5792.797252096183;5835.35811060784;5851.268591426072;5851.824445266639;5859.970700146504;5608.214849921004;5771.711414429283;5791.812678400928;5874.295084589845;6025.035994240922;5224.555912747412;5280.656757310781;5322.600804939645;5360.437154098822;5376.489233522829;621.4124402547749;5281.762320695578;5309.681419114865;5351.678899266037;5393.649412788176;5310.150375939831;5320.547753440962;5341.732913354317;5359.5712343012465;5361.329833770778;5140.537351638371;5332.866678333034;5341.893162136775;5359.22291267764;5373.570114390839;4111.835526578933;4400.097979914142;5205.141151709963;5265.157574788015;5273.499017593323;4454.33185022246;4694.85444752017;5633.380328163898;5683.3464151622675;5815.680137592431;4902.509749025105;5486.588505862076;6134.00801433197;6144.678894037804;6305.180326557564;6268.529860260499;6280.591761535531;6295.968520157416;6315.210598675166;6330.39861213184;4854;5684.175794509773;5751.827445176651;5818.534517238695;5841.56188285876;5299.4700529946695;6248.375162483806;6312.116303717483;6396.168498095218;6409.935900641027;6177.011678131477;6179.938200617937;6195.31851496335;6202.914489964238;6216.409441103088;5376.166694162411;6144.047672610753;6192.721327540272;6236.812895613139;6286.968565157145;6177.320494745574;6264.62412255257;6267.059941008885;6293.874122517615;6297.023961286008;6105.52039974972;6190.81427557174;6219.906701399483;6332.050192471166;6332.620042797447;4859.198232291632;4914.926276105862;4925.38432695913;4987.102321582078;4996.575291100225;4423.5576442355505;4426.981794187355;4433.933490997638;4447.310666846579;4483.75339356332;5830.4461076197695;5849.6782676952325;5863.824085277449;5870.647761134345;5872.618279811799;5543.25166102571;6093.146959425684;6188.783392581328;6224.719887605069;6300.369963003663;4835.443923948791;5896.410358964069;5950.107483877367;5968.612040217459;5970.402959704082;5302.655327403706;5376.1398176291605;5444.482774136451;5465.945340546623;5473.507384335349;6345.270293916166;6400.423961843457;6401.583897046677;6419.229692436844;6431.517636177212;5458.208559758733;6052.303985041776;6279.309275979547;6288.591241569284;6298.212723409574;6232.75068997235;6294.716737746904;6358.682065896594;6396.072569477493;6406.199225096863;6232.220972378453;6272.529560282906;6274.8431289216305;6278.434940855345;6300.149479820349;6118.405988989777;6291.905621415774;6295.559310848196;6299.181106456132;6305.747770089145;4717.339572459789;6156.199694039925;6205.689715514116;6261.812145635638;6294.402031806971;5975.581709280309;6108.8778224436155;6198.876022479435;6207.16203312547;6220.160278362363;4915.901681966269;5819.243498345188;5891.9116213255975;6098.451139397475;6147.108669243024;6200.441960223601;6249.875002500015;6268.561200715906;6272.749090036347;6278.246610406598;5582.581306401955;6119.279302525163;6127.050307202212;6150.692465376803;6156.569040167145 01:27:57 INFO - PROCESS | 1680 | |1;ext.html;441.60035168172794;465.9510751371106;546.5518275014489;581.3459857660132;599.0834023943363;25117.372065698368;37153.07117322065;37474.812625936866;37560.43659345112;37643;38720.83837484873;39044;39189.41215881764;39238.60761392385;39300;9375.531223438851;9607.4715890626;9613.038696130401;9616.23070154386;9648.179904708108;8671.089535598734;8914.910850891472;9443.102905223992;9658.565364558612;9670.758231044245;9655.662051828187;9671.90328096717;9688.564014619324;9772.609095636166;9791.902080979205;8412.915870841305;9535.71392858212;9662.3719458235;9760.267979901535;9772.853407198898;9475.336726429152;9574.664886729;9613.855792163124;9638.469884156368;9645.662401815973;38204.80897595494;38320.80839595812;38391;38562.80718596417;38587;2761.4615150045747;2911.708829117071;3099.3026569022013;3223.2103134731906;3249.0252924122906;26691.46617067648;26836.194914152606;27487.86256068727;27670.446591068066;27962.881484740585;2773.6671599408;2774;2811.6063751074867;2864.2266588021116;2957.6746557878614;349092;349216.2539187313;350894;351511.48488515045;354580;55624.44375556274;65266.67366663231;66979;67433.66283168651;67507;62585.43536411626;62945;63086;63251;63356.36643633597;15805.446809361847;15998.280077396545;16118.919405403132;16167.838321616868;16175.43385981485;12299.385030748426;12369.814452783216;12407.627771166879;12423.565175218824;12604.81092783609;16453.753193702105;19970.30103946355;20600.58798824015;20679.379618611467;20788.1684732609;8626.568671566396;8771.692990745421;8795.296376289882;8837.000449034627;8852.601632926533;931.7717159296016;999.9700008999741;1045.4459136657583;1062.7290041039485;1080.1790639114329;20451.59096818085;25218.495630087295;27560.586591201147;27860.303492412448;27903.44193116167;1030.9793804124026;1063.9574417023387;1071.4856868703066;1089.096050278267;1092.7705181911729;13831.585052448443;15643.921780391252;15726.606834828992;15888.126153061461;16217.026978381335;527537;529361;531572;534871;537967;57974.7101264491;58102.8379432409;58206.70896645574;58367;58490.830183396094;1410.9153450792985;1421.019496547379;1438.8129543159532;1448.6161167290466;1568.9607759806097;23840.40398990039;30159.396812064075;30166.396672066876;30277.697223027488;30317;49205;50093.49906501034;50133;50394.992100157055;50694.98610027705;491534;499864;505252;505568;506147;32077.35845283128;32088.679113209502;32317.192070198435;32624.184395390304;32627;43237.702868913984;43464.34803477887;44481.77759111184;44561.55438445574;45248.09503809839;35365.469517956735;36059.71163018382;36568.26863462663;36603.816980914926;36621.901342959754;36463.635363646026;37119.44320835135;37258.81370593238;37789.81105094457;37907.62092379041;29431.558526622546;36565.26869462649;37480;37522.437163442024;37534.249315013;27700.861495692392;29253.7074629251;32473.35053298968;33849.661503385636;34017.31965360729;20010.69983950271;21602.567948641252;23752.762472375056;24739.62890556679;25608.743912560636 01:27:57 INFO - PROCESS | 1680 | |2;jquery.html;304.93748781499795;318.5031351092298;357.9606243313236;360.31899709548946;362.64823121572084;15772.44796432125;19369.22523099076;19369.709454358177;20134.395968120978;20944.581108377824;17402;18538.702290839647;19498.025098745078;19955;19981.40055798325;4524.886877828064;5254.553362964143;5308.522232999029;5933.110033494989;5969.910451343233;5817.331006934193;5837.532997360222;5919.674417907014;5945.643261404308;5961.195238642771;3919.98040009801;5376.758045887925;5786.103154011114;5898.646081235118;5913.822585322426;5205.843824685266;5810.82567522975;5988.8502787430225;6009.819705408801;6045.576809623284;5206.843794686128;5465.152901300305;5630.577706671975;5744.626599271034;5754.395788442195;23746.7625323748;24088.03647854084;24327.391815204763;24537.877310613334;24578.631320530207;1986.1261045140093;2025.5442525431806;2067.2557879163487;2164.621191291518;2173.3371321746863;9694.36986595869;9807.26445516589;10132.290739648228;10817.621383251548;14996.625084372869;1701.9958224647517;1722.905240211788;1767.9292828286852;1799.2443173866877;1803.8105998870192;82630.58684706598;106133.46933265362;106388;106395.46802266016;107292;11252.987231149073;11302;11392.601258955896;11534.250273732181;11705.531778728755;13518.25649589282;13559.525416610568;13627.727445451035;13690.52083177084;13739.862601373858;8469.66121355139;8584.8712269316;8589.141085891486;8625.0943650917;8654.913450865412;8632.827343453097;8671.696490622799;8721.389502734875;8774.780630484289;8789.780255493664;4511.233090374644;4568.977155114269;4572.657050721143;4583.518730533313;4588.174128656807;1893.2332405375844;1931.2082046360924;1939.9612007759765;1942.2036964844629;1953.150379584885;400.12173279650887;401.3458063356768;690.8341997920463;938.2728385501291;952.3904700991371;11654.825177622342;11931.463084161234;11993.280403175837;12063.396830158457;12069.818952715716;419.5217452104603;419.9895002624898;441.76807176232734;451.3365352931186;468.5572134333091;6050.334463209044;6238.968805155945;6253.78111766086;6265.8120256392385;6268.529860260499;586738;590837;595997;599945;631035;110681;114958;123858.38070809768;124673;126293.73706263004;915.2174890468686;1011.7925825205815;1035.2649618770606;1043.4939054558533;1048.8584041154347;19102.33141840029;19195.712064318766;19445;19607.31374401889;19730.605387891876;44237.55762442463;51460;53096.46903530915;53457.465425345246;53891;59638.70180649069;77107.06036456746;78342;78504.21495784969;78680;6454.774082907075;6640.734370625121;7190.280971902768;8178.877316840371;8196.59017049157;9485.193758530602;12873.163244389085;12966;13537.458501659823;13682.726345472836;11563;11704.590339338083;11747.530098796295;11836.467358968695;11895.107866909842;9164.633414663605;10866.130709543375;11420.600278990196;11468.139889508488;11674.824877626672;11284.040856527286;11828.467718952495;11929.403529823301;11985.700357491132;12074.577389791315;6692.966535167293;8043.316318113026;8130.593470326578;8148.511089334659;8221.83556328882;10624.628138015132;11121.16591255643;11585.478653460783;11621.767564648491;11884.524619015143 01:27:57 INFO - PROCESS | 1680 | |3;mootools.html;1532.180283548302;1541.4913078684035;1787.177898166843;1904.2192700992578;1905.5807722301097;7912.090109637394;8545.4445461045;8707.172818582232;8927.062658420862;8957.283417326615;8601.526916019617;8633.740987770361;8761.693340733076;8764.693235736751;8777;2463.6181391884197;2464.7658472445087;2465.9753402466013;2486.589712697403;2494.1893884487613;2429.538387706339;2483.242611003643;2500.2249302716127;2502.687164104487;2505.4613258149493;2175.662772270293;2400.5558971590312;2461.876906154694;2466.7163276223287;2480.355107672009;2438.110089817204;2443.376938880583;2448.571499987504;2461.79074778644;2479.1818699829014;2434.221049264236;2457.1400009996537;2460.729319774823;2469.580171370871;2470.308313672175;8631.870521942175;8715.172058654418;8746.825063498758;8831.249343805785;8847.911520884838;5338.839834804962;5360.142377219626;5432.103702889019;5510.614257002011;5514.5864060195645;3594.3170797548382;3636.3636363636524;3659.8536058557625;3740.6259374062374;3740.8129593520216;1035.9223058270659;1049.1234887092198;1062.6121465665053;1089.1722291058772;1092.5629748100744;11804.291742495478;11975.580854670132;12109.818352724717;12124;12136.817947730791;4913.091078150554;4927.43334516528;4978.90042199154;5012.298278240976;5017.799288028511;10156.746081347877;10283;10291.691249262534;10313.535890884928;10317.587296508056;5503.367112782082;5517.2551705519245;5530.723463826793;5558.499735023786;5559.805406810823;4945.604351651859;4970.204767237225;5054.519820617035;5056.797728090909;5073.391193056783;3954.62431069048;3956.050547868548;3964.365701487748;3996.2806694794635;4007.078371974404;1237.55448038706;1330.1287656584952;1332.194022616303;1337.8595247499068;1348.1035111650642;1116.0290547223967;1118.5078565431347;1147.4836323654388;1262.9052821038274;1343.798430235453;6778.661066946633;7965.641546130438;7972.36221102322;8011.599420028975;8377.37169712274;1028.7222449938474;1043.7860238651058;1193.8985186259265;1197.4431889171576;1198.8141838015122;5273.815416460406;6321.968390158112;6350.110984462179;6403;6422.389872962061;10307.84538231927;10677.83983240252;10776.19178561611;10842.078423333947;10848.294860834021;10718;10746.999999999844;10915.290506117077;10941.890581094247;11130.554777808797;8423.620937057847;8472.364572657076;8501.319894408432;8528;8629.266512346396;8013.879791803244;8053.879191812245;8061.798455038671;8108.310793582612;8124.959375203086;9722.659706910224;9795.16741076988;9849.60601575929;9890.357126786736;9969.607294249474;10012.249081318785;10186.694399168036;10202.540885660015;10306.587736490457;10336.689899303034;7129.322714342129;7160.0333954917505;7247.420206383371;7968.163342848918;8160.959195204224;8187;8309.33525317961;8322.625481853453;8330.375221858263;8341.374396920377;6089.238845144357;7219.205887352282;7329.450291228072;7476.887846682413;7511.887321690288;6038;7088.751893683696;7237.855242895007;7283.162436319679;7435.665395057344;7623.970763947018;7724.806879827825;7742.225777422213;7806.88289675644;7807.594632966121;7110.3600675939415;7122.537035092702;7126.714931402893;7138.143422789299;7151.7854464366155;7027.086478757728;7206.279372062962;7206.855862882609;7207.279272072751;7224 01:27:57 INFO - PROCESS | 1680 | |4;prototype.html;321.45673811258973;326.24148853914653;326.3293930971852;330.8378894341773;334.9749765716908;6617.569857959229;6811.216710078343;6811.693473793679;6828.965855170723;6844;6812.455003599713;6848.178218613773;6864.485163612724;6867.622280774555;6881.0710554075185;5042.773075211624;5046.646734728571;5049.2173713074535;5049.596032317406;5057.367829021372;5053.722045287508;5059.392872855263;5059.772310246048;5065.986802639469;5073.467285934979;4983.72589507577;4994.076095922266;4998.450170481244;5000.149974504343;5021.824236151735;4823.541763532458;4997.30037794709;4999.700017998932;4999.7500124993785;5013.5989120870245;3940.802959851996;4245.787710614488;4258.084511829971;4266.850660226877;4293.957060429419;6500.609963402211;6510.1536800216145;6528.08606795049;6528.314526974695;6554.836129096763;5904.822855314304;5930.0511918093325;5931.555133365015;5939.940600593982;5942.554308426886;5031.84904452867;5816.360200377955;6217.658028808413;6499.537604039101;7216.242294559101;3666.7433279670436;4585.4726706428855;4733.715977041388;4746.406699162605;4757.833475828364;7756.728514502021;7760.573168475732;7772.611369431505;7785.883211751829;7791.844163116706;4840.903181936412;4844.660873738875;4845.2732090186755;4867.1969125093965;4868.659193856396;4926.605871530269;4937.21004639256;4942.184539550934;4942.827001054946;4957.4794646561595;5855.707214639251;5867.794627188028;5875.383084776123;5877.118432235199;5883.441073098049;6935.306469353024;7328.96335518319;7350.852982940311;7353.227911069368;7388.408927285912;1631.5676345768143;1652.3638399216388;1656.8177500474937;1657.9253933573018;1658.9585260368588;986.5116767200138;1039.752297243311;1051.279873286801;1052.4053909541085;1067.492940853104;6631.469482441393;6693.698783554752;6711.0940023096255;6716.5634233774645;6737.056812046318;7367.963160184165;7381.261873812576;7408.592527410937;7411.258874112654;7472.962635186789;5394.811181608625;6663.36698013688;6669.199696036507;6675.265720770712;6715.832104197337;3643.2349206666368;3951.3480275754755;3998.540167880673;4008.398740188995;4012.598740125964;5900.586958912921;7481.915122307235;7737.994060772064;7873.881891771513;7924.801879952932;7801.765947021599;7879.606019698992;7917.089534703583;7919.485233459922;7924.960375198087;6775.3224677532835;7900.525968441797;7961.283484486424;7999.960010197478;8022.0373555173755;7296.854062918818;7556.735514256975;7616.23837616234;7670.7315243966195;7679.654415551426;7418.703251869865;7438.776836694908;7439.851202976019;7455.552666840007;7466.626668666437;7819.491733037335;7902.24928631779;7940.483868548526;7943.880841787493;7983.20167983197;4690.3199036138885;4704.247320428715;4718.103560323528;4720.905581888274;4725.362076119817;6976.476764242803;7234.529755565872;7558.357539609195;7566.394688424803;7603.847923041619;6094.360092190256;6646.302138275411;7204.855902881808;7216.71133154689;7289;7286.271372862671;7305.488615796843;7318.560886346836;7340;7342.449316301192;7125.714971401293;7125.786226413215;7153.856922861618;7171.390431813145;7173.748918787817;7075.433965282868;7310.488265821342;7347.669354878936;7374.778756637309;7383.114026316876;7052.788416347517;7177.425805935408;7279.381252593589;7281.708731650887;7293 01:27:57 INFO - PROCESS | 1680 | |5;yui.html;707.8426772227407;712.7077898061796;723.826281692394;738.6196109003861;741.2328240271319;14508.5647430577;14556.63608409789;14576.344064517096;14809.25953702316;14810.629734256649;13597.456101755943;13639.93180034101;13643.454261829515;13663.385147668354;13668.794968075486;855.589317127779;869.7869022089566;881.3125761905724;883.0154377868662;887.5961437545933;865.645085514939;870.2733217763175;871.847426700325;875.6016012714232;882.5498995512303;893.1158153428092;893.673809059695;906.3202598051462;923.4828496042204;925.3476299209042;893.3478560650728;898.9146031127066;902.6524787956619;909.7498187998287;916.9220616247627;649.4252586460968;671.3454381977582;672.3545396419444;673.5823789250647;675.3752778679701;15263.007904486283;15309.387624495006;15431.3827446902;15441;15461.226938653135;12361.567345142967;12402;12459.377031148497;12483.50065997359;12710.110292279544;10044.89955100447;10088.192944564416;10119.392836429837;10146.239032072624;10234.48827558619;3468.8785892493643;3492.196794737199;3496.860125594973;3505.071156143624;3506.5441492605796;63725.406864828285;81062;81426;81861;82552;7778.572178530235;8883.511406872554;9116.133967273232;9156.725298241063;9310.906890931139;14757.040792348464;19355.8064419354;20550.58898822015;20613.278535251193;20625;7276.345128938315;7419.517731347445;7433.888491672629;7586.62066896653;7732.072151341875;4076.633103020683;4088.550259471456;4113.136241389342;4128.793560321972;4151.066010147753;3529.4705794130573;3571.8392672329805;3574.356615809127;3574.982125089358;3576.088097535112;633.7845132654919;643.9710213040424;646.2761706888315;663.7444583835162;669.1134247122485;495.6357077547999;526.8340472751071;586.1852025684302;609.1289456077851;623.4389049855166;7635.809104772314;8500.74497765068;8928.15182557656;9093.499857507768;9213;598.4344794169555;619.6344156947423;622.0948519903529;624.631467434216;626.1703243202775;3834.213986132836;3852.8073596320073;3991.1419044905483;4012.739171953872;4054.0675644601906;83497.58251208706;87706;87825.56087219651;89317;89463;69280.30719692839;71933.64033179905;72109.63945180345;72133;73070;60524;60626.69686651538;64320.39199020062;64352;64571.03143452852;8481.363897707573;8738;8823.073577274294;8905.376623636283;8949.32880034013;48232.517674822804;49512.257316141004;50744.74627626838;51013;51137.232941505164;64725.352746473814;65802.67098664476;65935.67032164808;66127.33872661211;66970.33029669836;10871.29336593119;10936.726581835517;10964.890351096386;11278.436078196222;11676.94161529187;10152.949235254073;10725.766536848363;11946.880531194924;12716.682082948;12721.300328482022;10499.94750026245;10586.8941310589;11328.660140195807;11650.88349116498;11769.08308901237;11380.430978450879;11498.367589782642;11598.710032248924;11844.881551184379;11870.52517899309;11303.830442543203;11377.2604780689;11710.824337635113;11774.470148843495;12210.145289829627;9266.953665231631;9386.48374339418;9480.620775168916;9824;10095.646652367132;8922.776930576787;9148.354521145571;9220.907790922272;9356.859647105435;9926.057024582653 01:27:57 INFO - PROCESS | 1680 | __end_tp_report 01:27:57 INFO - PROCESS | 1680 | __start_cc_report 01:27:57 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,338 01:27:57 INFO - PROCESS | 1680 | __end_cc_report 01:27:57 INFO - PROCESS | 1680 | __startTimestamp1456392477033__endTimestamp 01:27:57 INFO - PROCESS | 1680 | 01:27:57 INFO - PROCESS | 1680 | ------- Summary: start ------- 01:27:57 INFO - PROCESS | 1680 | Number of tests: 6 01:27:57 INFO - PROCESS | 1680 | 01:27:57 INFO - PROCESS | 1680 | [#0] dojo.html Cycles:165 Average:5701.95 Median:5968.61 stddev:776.06 (13.0%) stddev-sans-first:759.38 01:27:57 INFO - PROCESS | 1680 | Values: 3522.8 3563.2 3585.1 3619.2 3621.2 5792.8 5835.4 5851.3 5851.8 5860.0 5608.2 5771.7 5791.8 5874.3 6025.0 5224.6 5280.7 5322.6 5360.4 5376.5 621.4 5281.8 5309.7 5351.7 5393.6 5310.2 5320.5 5341.7 5359.6 5361.3 5140.5 5332.9 5341.9 5359.2 5373.6 4111.8 4400.1 5205.1 5265.2 5273.5 4454.3 4694.9 5633.4 5683.3 5815.7 4902.5 5486.6 6134.0 6144.7 6305.2 6268.5 6280.6 6296.0 6315.2 6330.4 4854.0 5684.2 5751.8 5818.5 5841.6 5299.5 6248.4 6312.1 6396.2 6409.9 6177.0 6179.9 6195.3 6202.9 6216.4 5376.2 6144.0 6192.7 6236.8 6287.0 6177.3 6264.6 6267.1 6293.9 6297.0 6105.5 6190.8 6219.9 6332.1 6332.6 4859.2 4914.9 4925.4 4987.1 4996.6 4423.6 4427.0 4433.9 4447.3 4483.8 5830.4 5849.7 5863.8 5870.6 5872.6 5543.3 6093.1 6188.8 6224.7 6300.4 4835.4 5896.4 5950.1 5968.6 5970.4 5302.7 5376.1 5444.5 5465.9 5473.5 6345.3 6400.4 6401.6 6419.2 6431.5 5458.2 6052.3 6279.3 6288.6 6298.2 6232.8 6294.7 6358.7 6396.1 6406.2 6232.2 6272.5 6274.8 6278.4 6300.1 6118.4 6291.9 6295.6 6299.2 6305.7 4717.3 6156.2 6205.7 6261.8 6294.4 5975.6 6108.9 6198.9 6207.2 6220.2 4915.9 5819.2 5891.9 6098.5 6147.1 6200.4 6249.9 6268.6 6272.7 6278.2 5582.6 6119.3 6127.1 6150.7 6156.6 01:27:57 INFO - PROCESS | 1680 | 01:27:57 INFO - PROCESS | 1680 | [#1] ext.html Cycles:180 Average:60718.72 Median:37477.41 stddev:124650.54 (332.6%) stddev-sans-first:124918.06 01:27:57 INFO - PROCESS | 1680 | Values: 441.6 466.0 546.6 581.3 599.1 25117.4 37153.1 37474.8 37560.4 37643.0 38720.8 39044.0 39189.4 39238.6 39300.0 9375.5 9607.5 9613.0 9616.2 9648.2 8671.1 8914.9 9443.1 9658.6 9670.8 9655.7 9671.9 9688.6 9772.6 9791.9 8412.9 9535.7 9662.4 9760.3 9772.9 9475.3 9574.7 9613.9 9638.5 9645.7 38204.8 38320.8 38391.0 38562.8 38587.0 2761.5 2911.7 3099.3 3223.2 3249.0 26691.5 26836.2 27487.9 27670.4 27962.9 2773.7 2774.0 2811.6 2864.2 2957.7 349092.0 349216.3 350894.0 351511.5 354580.0 55624.4 65266.7 66979.0 67433.7 67507.0 62585.4 62945.0 63086.0 63251.0 63356.4 15805.4 15998.3 16118.9 16167.8 16175.4 12299.4 12369.8 12407.6 12423.6 12604.8 16453.8 19970.3 20600.6 20679.4 20788.2 8626.6 8771.7 8795.3 8837.0 8852.6 931.8 1000.0 1045.4 1062.7 1080.2 20451.6 25218.5 27560.6 27860.3 27903.4 1031.0 1064.0 1071.5 1089.1 1092.8 13831.6 15643.9 15726.6 15888.1 16217.0 527537.0 529361.0 531572.0 534871.0 537967.0 57974.7 58102.8 58206.7 58367.0 58490.8 1410.9 1421.0 1438.8 1448.6 1569.0 23840.4 30159.4 30166.4 30277.7 30317.0 49205.0 50093.5 50133.0 50395.0 50695.0 491534.0 499864.0 505252.0 505568.0 506147.0 32077.4 32088.7 32317.2 32624.2 32627.0 43237.7 43464.3 44481.8 44561.6 45248.1 35365.5 36059.7 36568.3 36603.8 36621.9 36463.6 37119.4 37258.8 37789.8 37907.6 29431.6 36565.3 37480.0 37522.4 37534.2 27700.9 29253.7 32473.4 33849.7 34017.3 20010.7 21602.6 23752.8 24739.6 25608.7 01:27:57 INFO - PROCESS | 1680 | 01:27:57 INFO - PROCESS | 1680 | [#2] jquery.html Cycles:180 Average:33787.03 Median:338.23 stddev:99840.18 (29518.3%) stddev-sans-first:100088.60 01:27:57 INFO - PROCESS | 1680 | Values: 304.9 318.5 358.0 360.3 362.6 15772.4 19369.2 19369.7 20134.4 20944.6 17402.0 18538.7 19498.0 19955.0 19981.4 4524.9 5254.6 5308.5 5933.1 5969.9 5817.3 5837.5 5919.7 5945.6 5961.2 3920.0 5376.8 5786.1 5898.6 5913.8 5205.8 5810.8 5988.9 6009.8 6045.6 5206.8 5465.2 5630.6 5744.6 5754.4 23746.8 24088.0 24327.4 24537.9 24578.6 1986.1 2025.5 2067.3 2164.6 2173.3 9694.4 9807.3 10132.3 10817.6 14996.6 1702.0 1722.9 1767.9 1799.2 1803.8 82630.6 106133.5 106388.0 106395.5 107292.0 11253.0 11302.0 11392.6 11534.3 11705.5 13518.3 13559.5 13627.7 13690.5 13739.9 8469.7 8584.9 8589.1 8625.1 8654.9 8632.8 8671.7 8721.4 8774.8 8789.8 4511.2 4569.0 4572.7 4583.5 4588.2 1893.2 1931.2 1940.0 1942.2 1953.2 400.1 401.3 690.8 938.3 952.4 11654.8 11931.5 11993.3 12063.4 12069.8 419.5 420.0 441.8 451.3 468.6 6050.3 6239.0 6253.8 6265.8 6268.5 586738.0 590837.0 595997.0 599945.0 631035.0 110681.0 114958.0 123858.4 124673.0 126293.7 915.2 1011.8 1035.3 1043.5 1048.9 19102.3 19195.7 19445.0 19607.3 19730.6 44237.6 51460.0 53096.5 53457.5 53891.0 59638.7 77107.1 78342.0 78504.2 78680.0 6454.8 6640.7 7190.3 8178.9 8196.6 9485.2 12873.2 12966.0 13537.5 13682.7 11563.0 11704.6 11747.5 11836.5 11895.1 9164.6 10866.1 11420.6 11468.1 11674.8 11284.0 11828.5 11929.4 11985.7 12074.6 6693.0 8043.3 8130.6 8148.5 8221.8 10624.6 11121.2 11585.5 11621.8 11884.5 01:27:57 INFO - PROCESS | 1680 | 01:27:57 INFO - PROCESS | 1680 | [#3] mootools.html Cycles:180 Average:6108.59 Median:5015.05 stddev:3221.99 (64.2%) stddev-sans-first:3212.66 01:27:57 INFO - PROCESS | 1680 | Values: 1532.2 1541.5 1787.2 1904.2 1905.6 7912.1 8545.4 8707.2 8927.1 8957.3 8601.5 8633.7 8761.7 8764.7 8777.0 2463.6 2464.8 2466.0 2486.6 2494.2 2429.5 2483.2 2500.2 2502.7 2505.5 2175.7 2400.6 2461.9 2466.7 2480.4 2438.1 2443.4 2448.6 2461.8 2479.2 2434.2 2457.1 2460.7 2469.6 2470.3 8631.9 8715.2 8746.8 8831.2 8847.9 5338.8 5360.1 5432.1 5510.6 5514.6 3594.3 3636.4 3659.9 3740.6 3740.8 1035.9 1049.1 1062.6 1089.2 1092.6 11804.3 11975.6 12109.8 12124.0 12136.8 4913.1 4927.4 4978.9 5012.3 5017.8 10156.7 10283.0 10291.7 10313.5 10317.6 5503.4 5517.3 5530.7 5558.5 5559.8 4945.6 4970.2 5054.5 5056.8 5073.4 3954.6 3956.1 3964.4 3996.3 4007.1 1237.6 1330.1 1332.2 1337.9 1348.1 1116.0 1118.5 1147.5 1262.9 1343.8 6778.7 7965.6 7972.4 8011.6 8377.4 1028.7 1043.8 1193.9 1197.4 1198.8 5273.8 6322.0 6350.1 6403.0 6422.4 10307.8 10677.8 10776.2 10842.1 10848.3 10718.0 10747.0 10915.3 10941.9 11130.6 8423.6 8472.4 8501.3 8528.0 8629.3 8013.9 8053.9 8061.8 8108.3 8125.0 9722.7 9795.2 9849.6 9890.4 9969.6 10012.2 10186.7 10202.5 10306.6 10336.7 7129.3 7160.0 7247.4 7968.2 8161.0 8187.0 8309.3 8322.6 8330.4 8341.4 6089.2 7219.2 7329.5 7476.9 7511.9 6038.0 7088.8 7237.9 7283.2 7435.7 7624.0 7724.8 7742.2 7806.9 7807.6 7110.4 7122.5 7126.7 7138.1 7151.8 7027.1 7206.3 7206.9 7207.3 7224.0 01:27:57 INFO - PROCESS | 1680 | 01:27:57 INFO - PROCESS | 1680 | [#4] prototype.html Cycles:180 Average:5919.78 Median:6672.23 stddev:1906.29 (28.6%) stddev-sans-first:1864.76 01:27:57 INFO - PROCESS | 1680 | Values: 321.5 326.2 326.3 330.8 335.0 6617.6 6811.2 6811.7 6829.0 6844.0 6812.5 6848.2 6864.5 6867.6 6881.1 5042.8 5046.6 5049.2 5049.6 5057.4 5053.7 5059.4 5059.8 5066.0 5073.5 4983.7 4994.1 4998.5 5000.1 5021.8 4823.5 4997.3 4999.7 4999.8 5013.6 3940.8 4245.8 4258.1 4266.9 4294.0 6500.6 6510.2 6528.1 6528.3 6554.8 5904.8 5930.1 5931.6 5939.9 5942.6 5031.8 5816.4 6217.7 6499.5 7216.2 3666.7 4585.5 4733.7 4746.4 4757.8 7756.7 7760.6 7772.6 7785.9 7791.8 4840.9 4844.7 4845.3 4867.2 4868.7 4926.6 4937.2 4942.2 4942.8 4957.5 5855.7 5867.8 5875.4 5877.1 5883.4 6935.3 7329.0 7350.9 7353.2 7388.4 1631.6 1652.4 1656.8 1657.9 1659.0 986.5 1039.8 1051.3 1052.4 1067.5 6631.5 6693.7 6711.1 6716.6 6737.1 7368.0 7381.3 7408.6 7411.3 7473.0 5394.8 6663.4 6669.2 6675.3 6715.8 3643.2 3951.3 3998.5 4008.4 4012.6 5900.6 7481.9 7738.0 7873.9 7924.8 7801.8 7879.6 7917.1 7919.5 7925.0 6775.3 7900.5 7961.3 8000.0 8022.0 7296.9 7556.7 7616.2 7670.7 7679.7 7418.7 7438.8 7439.9 7455.6 7466.6 7819.5 7902.2 7940.5 7943.9 7983.2 4690.3 4704.2 4718.1 4720.9 4725.4 6976.5 7234.5 7558.4 7566.4 7603.8 6094.4 6646.3 7204.9 7216.7 7289.0 7286.3 7305.5 7318.6 7340.0 7342.4 7125.7 7125.8 7153.9 7171.4 7173.7 7075.4 7310.5 7347.7 7374.8 7383.1 7052.8 7177.4 7279.4 7281.7 7293.0 01:27:57 INFO - PROCESS | 1680 | 01:27:57 INFO - PROCESS | 1680 | [#5] yui.html Cycles:180 Average:17602.44 Median:624.04 stddev:24270.85 (3889.3%) stddev-sans-first:24305.79 01:27:57 INFO - PROCESS | 1680 | Values: 707.8 712.7 723.8 738.6 741.2 14508.6 14556.6 14576.3 14809.3 14810.6 13597.5 13639.9 13643.5 13663.4 13668.8 855.6 869.8 881.3 883.0 887.6 865.6 870.3 871.8 875.6 882.5 893.1 893.7 906.3 923.5 925.3 893.3 898.9 902.7 909.7 916.9 649.4 671.3 672.4 673.6 675.4 15263.0 15309.4 15431.4 15441.0 15461.2 12361.6 12402.0 12459.4 12483.5 12710.1 10044.9 10088.2 10119.4 10146.2 10234.5 3468.9 3492.2 3496.9 3505.1 3506.5 63725.4 81062.0 81426.0 81861.0 82552.0 7778.6 8883.5 9116.1 9156.7 9310.9 14757.0 19355.8 20550.6 20613.3 20625.0 7276.3 7419.5 7433.9 7586.6 7732.1 4076.6 4088.6 4113.1 4128.8 4151.1 3529.5 3571.8 3574.4 3575.0 3576.1 633.8 644.0 646.3 663.7 669.1 495.6 526.8 586.2 609.1 623.4 7635.8 8500.7 8928.2 9093.5 9213.0 598.4 619.6 622.1 624.6 626.2 3834.2 3852.8 3991.1 4012.7 4054.1 83497.6 87706.0 87825.6 89317.0 89463.0 69280.3 71933.6 72109.6 72133.0 73070.0 60524.0 60626.7 64320.4 64352.0 64571.0 8481.4 8738.0 8823.1 8905.4 8949.3 48232.5 49512.3 50744.7 51013.0 51137.2 64725.4 65802.7 65935.7 66127.3 66970.3 10871.3 10936.7 10964.9 11278.4 11676.9 10152.9 10725.8 11946.9 12716.7 12721.3 10499.9 10586.9 11328.7 11650.9 11769.1 11380.4 11498.4 11598.7 11844.9 11870.5 11303.8 11377.3 11710.8 11774.5 12210.1 9267.0 9386.5 9480.6 9824.0 10095.6 8922.8 9148.4 9220.9 9356.9 9926.1 01:27:57 INFO - PROCESS | 1680 | -------- Summary: end -------- 01:27:57 INFO - PROCESS | 1680 | 01:27:57 INFO - TEST-INFO | 1680: exit 0 01:27:57 INFO - TEST-OK | dromaeo_css | took 1110367ms 01:27:57 INFO - TEST-START | kraken 01:27:57 INFO - operating with platform_type : mac_ 01:27:57 INFO - Initialising browser for kraken test... 01:27:57 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmpUJVTyA/profile http://localhost:49274/getInfo.html) 01:28:00 INFO - PROCESS | 1687 | __metrics Screen width/height:1600/1200 01:28:00 INFO - PROCESS | 1687 | colorDepth:24 01:28:00 INFO - PROCESS | 1687 | Browser inner width/height: 1024/689 01:28:00 INFO - PROCESS | 1687 | __metrics 01:28:00 ERROR - PROCESS | 1687 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 01:28:01 INFO - TEST-INFO | 1687: exit 0 01:28:01 INFO - Browser initialized. 01:28:01 INFO - Running cycle 1/1 for kraken test... 01:28:01 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmpUJVTyA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:28:13 INFO - PROCESS | 1690 | RSS: Main: 255995904 01:28:13 INFO - PROCESS | 1690 | 01:28:16 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 01:28:16 INFO - PROCESS | 1690 | RSS: Main: 269004800 01:28:16 INFO - PROCESS | 1690 | 01:28:19 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 01:28:19 INFO - PROCESS | 1690 | RSS: Main: 276865024 01:28:19 INFO - PROCESS | 1690 | 01:28:23 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 01:28:23 INFO - PROCESS | 1690 | RSS: Main: 280788992 01:28:23 INFO - PROCESS | 1690 | 01:28:31 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 01:28:32 INFO - PROCESS | 1690 | RSS: Main: 281513984 01:28:32 INFO - PROCESS | 1690 | 01:28:34 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:28:34 INFO - PROCESS | 1690 | RSS: Main: 283328512 01:28:34 INFO - PROCESS | 1690 | 01:28:37 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 01:28:38 INFO - PROCESS | 1690 | RSS: Main: 283738112 01:28:38 INFO - PROCESS | 1690 | 01:28:41 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 01:28:42 INFO - PROCESS | 1690 | RSS: Main: 283541504 01:28:42 INFO - PROCESS | 1690 | 01:28:45 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 01:28:45 INFO - PROCESS | 1690 | RSS: Main: 283201536 01:28:45 INFO - PROCESS | 1690 | 01:28:47 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:28:47 INFO - PROCESS | 1690 | RSS: Main: 284176384 01:28:47 INFO - PROCESS | 1690 | 01:28:49 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:28:50 INFO - PROCESS | 1690 | RSS: Main: 282157056 01:28:50 INFO - PROCESS | 1690 | 01:28:52 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:28:53 INFO - PROCESS | 1690 | RSS: Main: 284602368 01:28:53 INFO - PROCESS | 1690 | 01:28:55 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:28:56 INFO - PROCESS | 1690 | RSS: Main: 284221440 01:28:56 INFO - PROCESS | 1690 | 01:28:58 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:28:59 INFO - PROCESS | 1690 | RSS: Main: 283652096 01:28:59 INFO - PROCESS | 1690 | 01:29:01 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 01:29:01 INFO - PROCESS | 1690 | RSS: Main: 285110272 01:29:01 INFO - PROCESS | 1690 | 01:29:01 INFO - PROCESS | 1690 | __start_tp_report 01:29:01 INFO - PROCESS | 1690 | _x_x_mozilla_page_load 01:29:01 INFO - PROCESS | 1690 | _x_x_mozilla_page_load_details 01:29:01 INFO - PROCESS | 1690 | |i|pagename|runs| 01:29:01 INFO - PROCESS | 1690 | |0;ai-astar;113;112;116;114;116;128;116;122;173;165 01:29:01 INFO - PROCESS | 1690 | |1;audio-beat-detection;152;124;144;154;122;142;142;122;156;123 01:29:01 INFO - PROCESS | 1690 | |2;audio-dft;195;193;202;201;204;230;197;203;202;200 01:29:01 INFO - PROCESS | 1690 | |3;audio-fft;69;67;77;105;57;57;62;67;117;57 01:29:01 INFO - PROCESS | 1690 | |4;audio-oscillator;83;82;116;79;81;86;113;78;80;113 01:29:01 INFO - PROCESS | 1690 | |5;imaging-gaussian-blur;103;141;130;107;129;140;87;80;75;116 01:29:01 INFO - PROCESS | 1690 | |6;imaging-darkroom;103;95;110;120;91;154;154;121;108;152 01:29:01 INFO - PROCESS | 1690 | |7;imaging-desaturate;147;149;93;131;147;91;91;92;91;138 01:29:01 INFO - PROCESS | 1690 | |8;json-parse-financial;54;57;54;55;54;57;57;73;70;70 01:29:01 INFO - PROCESS | 1690 | |9;json-stringify-tinderbox;60;68;65;64;78;73;68;81;99;66 01:29:01 INFO - PROCESS | 1690 | |10;stanford-crypto-aes;85;87;83;89;87;83;87;86;86;88 01:29:01 INFO - PROCESS | 1690 | |11;stanford-crypto-ccm;137;128;129;134;125;131;124;117;147;136 01:29:01 INFO - PROCESS | 1690 | |12;stanford-crypto-pbkdf2;139;141;143;145;139;153;175;181;168;130 01:29:01 INFO - PROCESS | 1690 | |13;stanford-crypto-sha256-iterative;66;68;66;68;69;68;67;68;67;70 01:29:01 INFO - PROCESS | 1690 | __end_tp_report 01:29:01 INFO - PROCESS | 1690 | __start_cc_report 01:29:01 INFO - PROCESS | 1690 | _x_x_mozilla_cycle_collect,892 01:29:01 INFO - PROCESS | 1690 | __end_cc_report 01:29:01 INFO - PROCESS | 1690 | __startTimestamp1456392541394__endTimestamp 01:29:01 INFO - PROCESS | 1690 | 01:29:01 INFO - PROCESS | 1690 | ------- Summary: start ------- 01:29:01 INFO - PROCESS | 1690 | Number of tests: 14 01:29:01 INFO - PROCESS | 1690 | 01:29:01 INFO - PROCESS | 1690 | [#0] ai-astar Cycles:10 Average:127.50 Median:119.00 stddev:22.45 (18.9%) stddev-sans-first:23.19 01:29:01 INFO - PROCESS | 1690 | Values: 113.0 112.0 116.0 114.0 116.0 128.0 116.0 122.0 173.0 165.0 01:29:01 INFO - PROCESS | 1690 | 01:29:01 INFO - PROCESS | 1690 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:143.00 stddev:14.05 (9.8%) stddev-sans-first:13.97 01:29:01 INFO - PROCESS | 1690 | Values: 152.0 124.0 144.0 154.0 122.0 142.0 142.0 122.0 156.0 123.0 01:29:01 INFO - PROCESS | 1690 | 01:29:01 INFO - PROCESS | 1690 | [#2] audio-dft Cycles:10 Average:202.70 Median:202.00 stddev:10.24 (5.1%) stddev-sans-first:10.48 01:29:01 INFO - PROCESS | 1690 | Values: 195.0 193.0 202.0 201.0 204.0 230.0 197.0 203.0 202.0 200.0 01:29:01 INFO - PROCESS | 1690 | 01:29:01 INFO - PROCESS | 1690 | [#3] audio-fft Cycles:10 Average:73.50 Median:64.50 stddev:20.95 (32.5%) stddev-sans-first:22.16 01:29:01 INFO - PROCESS | 1690 | Values: 69.0 67.0 77.0 105.0 57.0 57.0 62.0 67.0 117.0 57.0 01:29:01 INFO - PROCESS | 1690 | 01:29:01 INFO - PROCESS | 1690 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:80.50 stddev:15.98 (19.8%) stddev-sans-first:16.67 01:29:01 INFO - PROCESS | 1690 | Values: 83.0 82.0 116.0 79.0 81.0 86.0 113.0 78.0 80.0 113.0 01:29:01 INFO - PROCESS | 1690 | 01:29:01 INFO - PROCESS | 1690 | [#5] imaging-gaussian-blur Cycles:10 Average:110.80 Median:140.50 stddev:24.41 (17.4%) stddev-sans-first:25.73 01:29:01 INFO - PROCESS | 1690 | Values: 103.0 141.0 130.0 107.0 129.0 140.0 87.0 80.0 75.0 116.0 01:29:01 INFO - PROCESS | 1690 | 01:29:01 INFO - PROCESS | 1690 | [#6] imaging-darkroom Cycles:10 Average:120.80 Median:153.00 stddev:24.33 (15.9%) stddev-sans-first:24.94 01:29:01 INFO - PROCESS | 1690 | Values: 103.0 95.0 110.0 120.0 91.0 154.0 154.0 121.0 108.0 152.0 01:29:01 INFO - PROCESS | 1690 | 01:29:01 INFO - PROCESS | 1690 | [#7] imaging-desaturate Cycles:10 Average:117.00 Median:91.00 stddev:27.26 (30.0%) stddev-sans-first:26.67 01:29:01 INFO - PROCESS | 1690 | Values: 147.0 149.0 93.0 131.0 147.0 91.0 91.0 92.0 91.0 138.0 01:29:01 INFO - PROCESS | 1690 | 01:29:01 INFO - PROCESS | 1690 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:57.00 stddev:7.67 (13.4%) stddev-sans-first:7.81 01:29:01 INFO - PROCESS | 1690 | Values: 54.0 57.0 54.0 55.0 54.0 57.0 57.0 73.0 70.0 70.0 01:29:01 INFO - PROCESS | 1690 | 01:29:01 INFO - PROCESS | 1690 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:70.50 stddev:11.41 (16.2%) stddev-sans-first:11.22 01:29:01 INFO - PROCESS | 1690 | Values: 60.0 68.0 65.0 64.0 78.0 73.0 68.0 81.0 99.0 66.0 01:29:01 INFO - PROCESS | 1690 | 01:29:01 INFO - PROCESS | 1690 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:87.00 stddev:1.97 (2.3%) stddev-sans-first:2.05 01:29:01 INFO - PROCESS | 1690 | Values: 85.0 87.0 83.0 89.0 87.0 83.0 87.0 86.0 86.0 88.0 01:29:01 INFO - PROCESS | 1690 | 01:29:01 INFO - PROCESS | 1690 | [#11] stanford-crypto-ccm Cycles:10 Average:130.80 Median:132.50 stddev:8.30 (6.3%) stddev-sans-first:8.49 01:29:01 INFO - PROCESS | 1690 | Values: 137.0 128.0 129.0 134.0 125.0 131.0 124.0 117.0 147.0 136.0 01:29:01 INFO - PROCESS | 1690 | 01:29:01 INFO - PROCESS | 1690 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.40 Median:149.00 stddev:17.31 (11.6%) stddev-sans-first:17.77 01:29:01 INFO - PROCESS | 1690 | Values: 139.0 141.0 143.0 145.0 139.0 153.0 175.0 181.0 168.0 130.0 01:29:01 INFO - PROCESS | 1690 | 01:29:01 INFO - PROCESS | 1690 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.25 (1.8%) stddev-sans-first:1.17 01:29:01 INFO - PROCESS | 1690 | Values: 66.0 68.0 66.0 68.0 69.0 68.0 67.0 68.0 67.0 70.0 01:29:01 INFO - PROCESS | 1690 | -------- Summary: end -------- 01:29:01 INFO - PROCESS | 1690 | 01:29:02 INFO - TEST-INFO | 1690: exit 0 01:29:02 INFO - TEST-OK | kraken | took 64477ms 01:29:02 INFO - SUITE-END | took 1174s 01:29:02 INFO - Completed test suite (00:19:35) 01:29:02 INFO - Working with test: dromaeo_css 01:29:02 INFO - Generating results file: dromaeo_css 01:29:02 INFO - Working with test: kraken 01:29:02 INFO - Generating results file: kraken 01:29:02 INFO - javascript benchmark 01:29:02 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:29:02 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 01:29:02 INFO - process_Request line: dromaeo_css 7456.31 graph.html#tests=[[72,64,61]] 01:29:02 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:29:02 INFO - process_Request line: kraken 1549.80 graph.html#tests=[[232,64,61]] 01:29:02 INFO - RETURN: dromaeo_css: 7456.31 01:29:02 INFO - RETURN: kraken: 1549.80 01:29:02 INFO - javascript benchmark 01:29:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3522.841472133754, 3563.198280386912, 3585.0858031202038, 3619.203775169462, 3621.2214373909605, 5792.797252096183, 5835.35811060784, 5851.268591426072, 5851.824445266639, 5859.970700146504, 5608.214849921004, 5771.711414429283, 5791.812678400928, 5874.295084589845, 6025.035994240922, 5224.555912747412, 5280.656757310781, 5322.600804939645, 5360.437154098822, 5376.489233522829, 621.4124402547749, 5281.762320695578, 5309.681419114865, 5351.678899266037, 5393.649412788176, 5310.150375939831, 5320.547753440962, 5341.732913354317, 5359.5712343012465, 5361.329833770778, 5140.537351638371, 5332.866678333034, 5341.893162136775, 5359.22291267764, 5373.570114390839, 4111.835526578933, 4400.097979914142, 5205.141151709963, 5265.157574788015, 5273.499017593323, 4454.33185022246, 4694.85444752017, 5633.380328163898, 5683.3464151622675, 5815.680137592431, 4902.509749025105, 5486.588505862076, 6134.00801433197, 6144.678894037804, 6305.180326557564, 6268.529860260499, 6280.591761535531, 6295.968520157416, 6315.210598675166, 6330.39861213184, 4854.0, 5684.175794509773, 5751.827445176651, 5818.534517238695, 5841.56188285876, 5299.4700529946695, 6248.375162483806, 6312.116303717483, 6396.168498095218, 6409.935900641027, 6177.011678131477, 6179.938200617937, 6195.31851496335, 6202.914489964238, 6216.409441103088, 5376.166694162411, 6144.047672610753, 6192.721327540272, 6236.812895613139, 6286.968565157145, 6177.320494745574, 6264.62412255257, 6267.059941008885, 6293.874122517615, 6297.023961286008, 6105.52039974972, 6190.81427557174, 6219.906701399483, 6332.050192471166, 6332.620042797447, 4859.198232291632, 4914.926276105862, 4925.38432695913, 4987.102321582078, 4996.575291100225, 4423.5576442355505, 4426.981794187355, 4433.933490997638, 4447.310666846579, 4483.75339356332, 5830.4461076197695, 5849.6782676952325, 5863.824085277449, 5870.647761134345, 5872.618279811799, 5543.25166102571, 6093.146959425684, 6188.783392581328, 6224.719887605069, 6300.369963003663, 4835.443923948791, 5896.410358964069, 5950.107483877367, 5968.612040217459, 5970.402959704082, 5302.655327403706, 5376.1398176291605, 5444.482774136451, 5465.945340546623, 5473.507384335349, 6345.270293916166, 6400.423961843457, 6401.583897046677, 6419.229692436844, 6431.517636177212, 5458.208559758733, 6052.303985041776, 6279.309275979547, 6288.591241569284, 6298.212723409574, 6232.75068997235, 6294.716737746904, 6358.682065896594, 6396.072569477493, 6406.199225096863, 6232.220972378453, 6272.529560282906, 6274.8431289216305, 6278.434940855345, 6300.149479820349, 6118.405988989777, 6291.905621415774, 6295.559310848196, 6299.181106456132, 6305.747770089145, 4717.339572459789, 6156.199694039925, 6205.689715514116, 6261.812145635638, 6294.402031806971, 5975.581709280309, 6108.8778224436155, 6198.876022479435, 6207.16203312547, 6220.160278362363, 4915.901681966269, 5819.243498345188, 5891.9116213255975, 6098.451139397475, 6147.108669243024, 6200.441960223601, 6249.875002500015, 6268.561200715906, 6272.749090036347, 6278.246610406598, 5582.581306401955, 6119.279302525163, 6127.050307202212, 6150.692465376803, 6156.569040167145], "unit": "score", "name": "dojo.html", "value": 5659.696242077895}, {"lowerIsBetter": false, "replicates": [441.60035168172794, 465.9510751371106, 546.5518275014489, 581.3459857660132, 599.0834023943363, 25117.372065698368, 37153.07117322065, 37474.812625936866, 37560.43659345112, 37643.0, 38720.83837484873, 39044.0, 39189.41215881764, 39238.60761392385, 39300.0, 9375.531223438851, 9607.4715890626, 9613.038696130401, 9616.23070154386, 9648.179904708108, 8671.089535598734, 8914.910850891472, 9443.102905223992, 9658.565364558612, 9670.758231044245, 9655.662051828187, 9671.90328096717, 9688.564014619324, 9772.609095636166, 9791.902080979205, 8412.915870841305, 9535.71392858212, 9662.3719458235, 9760.267979901535, 9772.853407198898, 9475.336726429152, 9574.664886729, 9613.855792163124, 9638.469884156368, 9645.662401815973, 38204.80897595494, 38320.80839595812, 38391.0, 38562.80718596417, 38587.0, 2761.4615150045747, 2911.708829117071, 3099.3026569022013, 3223.2103134731906, 3249.0252924122906, 26691.46617067648, 26836.194914152606, 27487.86256068727, 27670.446591068066, 27962.881484740585, 2773.6671599408, 2774.0, 2811.6063751074867, 2864.2266588021116, 2957.6746557878614, 349092.0, 349216.2539187313, 350894.0, 351511.48488515045, 354580.0, 55624.44375556274, 65266.67366663231, 66979.0, 67433.66283168651, 67507.0, 62585.43536411626, 62945.0, 63086.0, 63251.0, 63356.36643633597, 15805.446809361847, 15998.280077396545, 16118.919405403132, 16167.838321616868, 16175.43385981485, 12299.385030748426, 12369.814452783216, 12407.627771166879, 12423.565175218824, 12604.81092783609, 16453.753193702105, 19970.30103946355, 20600.58798824015, 20679.379618611467, 20788.1684732609, 8626.568671566396, 8771.692990745421, 8795.296376289882, 8837.000449034627, 8852.601632926533, 931.7717159296016, 999.9700008999741, 1045.4459136657583, 1062.7290041039485, 1080.1790639114329, 20451.59096818085, 25218.495630087295, 27560.586591201147, 27860.303492412448, 27903.44193116167, 1030.9793804124026, 1063.9574417023387, 1071.4856868703066, 1089.096050278267, 1092.7705181911729, 13831.585052448443, 15643.921780391252, 15726.606834828992, 15888.126153061461, 16217.026978381335, 527537.0, 529361.0, 531572.0, 534871.0, 537967.0, 57974.7101264491, 58102.8379432409, 58206.70896645574, 58367.0, 58490.830183396094, 1410.9153450792985, 1421.019496547379, 1438.8129543159532, 1448.6161167290466, 1568.9607759806097, 23840.40398990039, 30159.396812064075, 30166.396672066876, 30277.697223027488, 30317.0, 49205.0, 50093.49906501034, 50133.0, 50394.992100157055, 50694.98610027705, 491534.0, 499864.0, 505252.0, 505568.0, 506147.0, 32077.35845283128, 32088.679113209502, 32317.192070198435, 32624.184395390304, 32627.0, 43237.702868913984, 43464.34803477887, 44481.77759111184, 44561.55438445574, 45248.09503809839, 35365.469517956735, 36059.71163018382, 36568.26863462663, 36603.816980914926, 36621.901342959754, 36463.635363646026, 37119.44320835135, 37258.81370593238, 37789.81105094457, 37907.62092379041, 29431.558526622546, 36565.26869462649, 37480.0, 37522.437163442024, 37534.249315013, 27700.861495692392, 29253.7074629251, 32473.35053298968, 33849.661503385636, 34017.31965360729, 20010.69983950271, 21602.567948641252, 23752.762472375056, 24739.62890556679, 25608.743912560636], "unit": "score", "name": "ext.html", "value": 19276.193001164374}, {"lowerIsBetter": false, "replicates": [304.93748781499795, 318.5031351092298, 357.9606243313236, 360.31899709548946, 362.64823121572084, 15772.44796432125, 19369.22523099076, 19369.709454358177, 20134.395968120978, 20944.581108377824, 17402.0, 18538.702290839647, 19498.025098745078, 19955.0, 19981.40055798325, 4524.886877828064, 5254.553362964143, 5308.522232999029, 5933.110033494989, 5969.910451343233, 5817.331006934193, 5837.532997360222, 5919.674417907014, 5945.643261404308, 5961.195238642771, 3919.98040009801, 5376.758045887925, 5786.103154011114, 5898.646081235118, 5913.822585322426, 5205.843824685266, 5810.82567522975, 5988.8502787430225, 6009.819705408801, 6045.576809623284, 5206.843794686128, 5465.152901300305, 5630.577706671975, 5744.626599271034, 5754.395788442195, 23746.7625323748, 24088.03647854084, 24327.391815204763, 24537.877310613334, 24578.631320530207, 1986.1261045140093, 2025.5442525431806, 2067.2557879163487, 2164.621191291518, 2173.3371321746863, 9694.36986595869, 9807.26445516589, 10132.290739648228, 10817.621383251548, 14996.625084372869, 1701.9958224647517, 1722.905240211788, 1767.9292828286852, 1799.2443173866877, 1803.8105998870192, 82630.58684706598, 106133.46933265362, 106388.0, 106395.46802266016, 107292.0, 11252.987231149073, 11302.0, 11392.601258955896, 11534.250273732181, 11705.531778728755, 13518.25649589282, 13559.525416610568, 13627.727445451035, 13690.52083177084, 13739.862601373858, 8469.66121355139, 8584.8712269316, 8589.141085891486, 8625.0943650917, 8654.913450865412, 8632.827343453097, 8671.696490622799, 8721.389502734875, 8774.780630484289, 8789.780255493664, 4511.233090374644, 4568.977155114269, 4572.657050721143, 4583.518730533313, 4588.174128656807, 1893.2332405375844, 1931.2082046360924, 1939.9612007759765, 1942.2036964844629, 1953.150379584885, 400.12173279650887, 401.3458063356768, 690.8341997920463, 938.2728385501291, 952.3904700991371, 11654.825177622342, 11931.463084161234, 11993.280403175837, 12063.396830158457, 12069.818952715716, 419.5217452104603, 419.9895002624898, 441.76807176232734, 451.3365352931186, 468.5572134333091, 6050.334463209044, 6238.968805155945, 6253.78111766086, 6265.8120256392385, 6268.529860260499, 586738.0, 590837.0, 595997.0, 599945.0, 631035.0, 110681.0, 114958.0, 123858.38070809768, 124673.0, 126293.73706263004, 915.2174890468686, 1011.7925825205815, 1035.2649618770606, 1043.4939054558533, 1048.8584041154347, 19102.33141840029, 19195.712064318766, 19445.0, 19607.31374401889, 19730.605387891876, 44237.55762442463, 51460.0, 53096.46903530915, 53457.465425345246, 53891.0, 59638.70180649069, 77107.06036456746, 78342.0, 78504.21495784969, 78680.0, 6454.774082907075, 6640.734370625121, 7190.280971902768, 8178.877316840371, 8196.59017049157, 9485.193758530602, 12873.163244389085, 12966.0, 13537.458501659823, 13682.726345472836, 11563.0, 11704.590339338083, 11747.530098796295, 11836.467358968695, 11895.107866909842, 9164.633414663605, 10866.130709543375, 11420.600278990196, 11468.139889508488, 11674.824877626672, 11284.040856527286, 11828.467718952495, 11929.403529823301, 11985.700357491132, 12074.577389791315, 6692.966535167293, 8043.316318113026, 8130.593470326578, 8148.511089334659, 8221.83556328882, 10624.628138015132, 11121.16591255643, 11585.478653460783, 11621.767564648491, 11884.524619015143], "unit": "score", "name": "jquery.html", "value": 8813.600785712431}, {"lowerIsBetter": false, "replicates": [1532.180283548302, 1541.4913078684035, 1787.177898166843, 1904.2192700992578, 1905.5807722301097, 7912.090109637394, 8545.4445461045, 8707.172818582232, 8927.062658420862, 8957.283417326615, 8601.526916019617, 8633.740987770361, 8761.693340733076, 8764.693235736751, 8777.0, 2463.6181391884197, 2464.7658472445087, 2465.9753402466013, 2486.589712697403, 2494.1893884487613, 2429.538387706339, 2483.242611003643, 2500.2249302716127, 2502.687164104487, 2505.4613258149493, 2175.662772270293, 2400.5558971590312, 2461.876906154694, 2466.7163276223287, 2480.355107672009, 2438.110089817204, 2443.376938880583, 2448.571499987504, 2461.79074778644, 2479.1818699829014, 2434.221049264236, 2457.1400009996537, 2460.729319774823, 2469.580171370871, 2470.308313672175, 8631.870521942175, 8715.172058654418, 8746.825063498758, 8831.249343805785, 8847.911520884838, 5338.839834804962, 5360.142377219626, 5432.103702889019, 5510.614257002011, 5514.5864060195645, 3594.3170797548382, 3636.3636363636524, 3659.8536058557625, 3740.6259374062374, 3740.8129593520216, 1035.9223058270659, 1049.1234887092198, 1062.6121465665053, 1089.1722291058772, 1092.5629748100744, 11804.291742495478, 11975.580854670132, 12109.818352724717, 12124.0, 12136.817947730791, 4913.091078150554, 4927.43334516528, 4978.90042199154, 5012.298278240976, 5017.799288028511, 10156.746081347877, 10283.0, 10291.691249262534, 10313.535890884928, 10317.587296508056, 5503.367112782082, 5517.2551705519245, 5530.723463826793, 5558.499735023786, 5559.805406810823, 4945.604351651859, 4970.204767237225, 5054.519820617035, 5056.797728090909, 5073.391193056783, 3954.62431069048, 3956.050547868548, 3964.365701487748, 3996.2806694794635, 4007.078371974404, 1237.55448038706, 1330.1287656584952, 1332.194022616303, 1337.8595247499068, 1348.1035111650642, 1116.0290547223967, 1118.5078565431347, 1147.4836323654388, 1262.9052821038274, 1343.798430235453, 6778.661066946633, 7965.641546130438, 7972.36221102322, 8011.599420028975, 8377.37169712274, 1028.7222449938474, 1043.7860238651058, 1193.8985186259265, 1197.4431889171576, 1198.8141838015122, 5273.815416460406, 6321.968390158112, 6350.110984462179, 6403.0, 6422.389872962061, 10307.84538231927, 10677.83983240252, 10776.19178561611, 10842.078423333947, 10848.294860834021, 10718.0, 10746.999999999844, 10915.290506117077, 10941.890581094247, 11130.554777808797, 8423.620937057847, 8472.364572657076, 8501.319894408432, 8528.0, 8629.266512346396, 8013.879791803244, 8053.879191812245, 8061.798455038671, 8108.310793582612, 8124.959375203086, 9722.659706910224, 9795.16741076988, 9849.60601575929, 9890.357126786736, 9969.607294249474, 10012.249081318785, 10186.694399168036, 10202.540885660015, 10306.587736490457, 10336.689899303034, 7129.322714342129, 7160.0333954917505, 7247.420206383371, 7968.163342848918, 8160.959195204224, 8187.0, 8309.33525317961, 8322.625481853453, 8330.375221858263, 8341.374396920377, 6089.238845144357, 7219.205887352282, 7329.450291228072, 7476.887846682413, 7511.887321690288, 6038.0, 7088.751893683696, 7237.855242895007, 7283.162436319679, 7435.665395057344, 7623.970763947018, 7724.806879827825, 7742.225777422213, 7806.88289675644, 7807.594632966121, 7110.3600675939415, 7122.537035092702, 7126.714931402893, 7138.143422789299, 7151.7854464366155, 7027.086478757728, 7206.279372062962, 7206.855862882609, 7207.279272072751, 7224.0], "unit": "score", "name": "mootools.html", "value": 4979.237215905169}, {"lowerIsBetter": false, "replicates": [321.45673811258973, 326.24148853914653, 326.3293930971852, 330.8378894341773, 334.9749765716908, 6617.569857959229, 6811.216710078343, 6811.693473793679, 6828.965855170723, 6844.0, 6812.455003599713, 6848.178218613773, 6864.485163612724, 6867.622280774555, 6881.0710554075185, 5042.773075211624, 5046.646734728571, 5049.2173713074535, 5049.596032317406, 5057.367829021372, 5053.722045287508, 5059.392872855263, 5059.772310246048, 5065.986802639469, 5073.467285934979, 4983.72589507577, 4994.076095922266, 4998.450170481244, 5000.149974504343, 5021.824236151735, 4823.541763532458, 4997.30037794709, 4999.700017998932, 4999.7500124993785, 5013.5989120870245, 3940.802959851996, 4245.787710614488, 4258.084511829971, 4266.850660226877, 4293.957060429419, 6500.609963402211, 6510.1536800216145, 6528.08606795049, 6528.314526974695, 6554.836129096763, 5904.822855314304, 5930.0511918093325, 5931.555133365015, 5939.940600593982, 5942.554308426886, 5031.84904452867, 5816.360200377955, 6217.658028808413, 6499.537604039101, 7216.242294559101, 3666.7433279670436, 4585.4726706428855, 4733.715977041388, 4746.406699162605, 4757.833475828364, 7756.728514502021, 7760.573168475732, 7772.611369431505, 7785.883211751829, 7791.844163116706, 4840.903181936412, 4844.660873738875, 4845.2732090186755, 4867.1969125093965, 4868.659193856396, 4926.605871530269, 4937.21004639256, 4942.184539550934, 4942.827001054946, 4957.4794646561595, 5855.707214639251, 5867.794627188028, 5875.383084776123, 5877.118432235199, 5883.441073098049, 6935.306469353024, 7328.96335518319, 7350.852982940311, 7353.227911069368, 7388.408927285912, 1631.5676345768143, 1652.3638399216388, 1656.8177500474937, 1657.9253933573018, 1658.9585260368588, 986.5116767200138, 1039.752297243311, 1051.279873286801, 1052.4053909541085, 1067.492940853104, 6631.469482441393, 6693.698783554752, 6711.0940023096255, 6716.5634233774645, 6737.056812046318, 7367.963160184165, 7381.261873812576, 7408.592527410937, 7411.258874112654, 7472.962635186789, 5394.811181608625, 6663.36698013688, 6669.199696036507, 6675.265720770712, 6715.832104197337, 3643.2349206666368, 3951.3480275754755, 3998.540167880673, 4008.398740188995, 4012.598740125964, 5900.586958912921, 7481.915122307235, 7737.994060772064, 7873.881891771513, 7924.801879952932, 7801.765947021599, 7879.606019698992, 7917.089534703583, 7919.485233459922, 7924.960375198087, 6775.3224677532835, 7900.525968441797, 7961.283484486424, 7999.960010197478, 8022.0373555173755, 7296.854062918818, 7556.735514256975, 7616.23837616234, 7670.7315243966195, 7679.654415551426, 7418.703251869865, 7438.776836694908, 7439.851202976019, 7455.552666840007, 7466.626668666437, 7819.491733037335, 7902.24928631779, 7940.483868548526, 7943.880841787493, 7983.20167983197, 4690.3199036138885, 4704.247320428715, 4718.103560323528, 4720.905581888274, 4725.362076119817, 6976.476764242803, 7234.529755565872, 7558.357539609195, 7566.394688424803, 7603.847923041619, 6094.360092190256, 6646.302138275411, 7204.855902881808, 7216.71133154689, 7289.0, 7286.271372862671, 7305.488615796843, 7318.560886346836, 7340.0, 7342.449316301192, 7125.714971401293, 7125.786226413215, 7153.856922861618, 7171.390431813145, 7173.748918787817, 7075.433965282868, 7310.488265821342, 7347.669354878936, 7374.778756637309, 7383.114026316876, 7052.788416347517, 7177.425805935408, 7279.381252593589, 7281.708731650887, 7293.0], "unit": "score", "name": "prototype.html", "value": 5273.685531188831}, {"lowerIsBetter": false, "replicates": [707.8426772227407, 712.7077898061796, 723.826281692394, 738.6196109003861, 741.2328240271319, 14508.5647430577, 14556.63608409789, 14576.344064517096, 14809.25953702316, 14810.629734256649, 13597.456101755943, 13639.93180034101, 13643.454261829515, 13663.385147668354, 13668.794968075486, 855.589317127779, 869.7869022089566, 881.3125761905724, 883.0154377868662, 887.5961437545933, 865.645085514939, 870.2733217763175, 871.847426700325, 875.6016012714232, 882.5498995512303, 893.1158153428092, 893.673809059695, 906.3202598051462, 923.4828496042204, 925.3476299209042, 893.3478560650728, 898.9146031127066, 902.6524787956619, 909.7498187998287, 916.9220616247627, 649.4252586460968, 671.3454381977582, 672.3545396419444, 673.5823789250647, 675.3752778679701, 15263.007904486283, 15309.387624495006, 15431.3827446902, 15441.0, 15461.226938653135, 12361.567345142967, 12402.0, 12459.377031148497, 12483.50065997359, 12710.110292279544, 10044.89955100447, 10088.192944564416, 10119.392836429837, 10146.239032072624, 10234.48827558619, 3468.8785892493643, 3492.196794737199, 3496.860125594973, 3505.071156143624, 3506.5441492605796, 63725.406864828285, 81062.0, 81426.0, 81861.0, 82552.0, 7778.572178530235, 8883.511406872554, 9116.133967273232, 9156.725298241063, 9310.906890931139, 14757.040792348464, 19355.8064419354, 20550.58898822015, 20613.278535251193, 20625.0, 7276.345128938315, 7419.517731347445, 7433.888491672629, 7586.62066896653, 7732.072151341875, 4076.633103020683, 4088.550259471456, 4113.136241389342, 4128.793560321972, 4151.066010147753, 3529.4705794130573, 3571.8392672329805, 3574.356615809127, 3574.982125089358, 3576.088097535112, 633.7845132654919, 643.9710213040424, 646.2761706888315, 663.7444583835162, 669.1134247122485, 495.6357077547999, 526.8340472751071, 586.1852025684302, 609.1289456077851, 623.4389049855166, 7635.809104772314, 8500.74497765068, 8928.15182557656, 9093.499857507768, 9213.0, 598.4344794169555, 619.6344156947423, 622.0948519903529, 624.631467434216, 626.1703243202775, 3834.213986132836, 3852.8073596320073, 3991.1419044905483, 4012.739171953872, 4054.0675644601906, 83497.58251208706, 87706.0, 87825.56087219651, 89317.0, 89463.0, 69280.30719692839, 71933.64033179905, 72109.63945180345, 72133.0, 73070.0, 60524.0, 60626.69686651538, 64320.39199020062, 64352.0, 64571.03143452852, 8481.363897707573, 8738.0, 8823.073577274294, 8905.376623636283, 8949.32880034013, 48232.517674822804, 49512.257316141004, 50744.74627626838, 51013.0, 51137.232941505164, 64725.352746473814, 65802.67098664476, 65935.67032164808, 66127.33872661211, 66970.33029669836, 10871.29336593119, 10936.726581835517, 10964.890351096386, 11278.436078196222, 11676.94161529187, 10152.949235254073, 10725.766536848363, 11946.880531194924, 12716.682082948, 12721.300328482022, 10499.94750026245, 10586.8941310589, 11328.660140195807, 11650.88349116498, 11769.08308901237, 11380.430978450879, 11498.367589782642, 11598.710032248924, 11844.881551184379, 11870.52517899309, 11303.830442543203, 11377.2604780689, 11710.824337635113, 11774.470148843495, 12210.145289829627, 9266.953665231631, 9386.48374339418, 9480.620775168916, 9824.0, 10095.646652367132, 8922.776930576787, 9148.354521145571, 9220.907790922272, 9356.859647105435, 9926.057024582653], "unit": "score", "name": "yui.html", "value": 6805.5793609460725}], "name": "dromaeo_css", "value": 7456.306069042463}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 112.0, 116.0, 114.0, 116.0, 128.0, 116.0, 122.0, 173.0, 165.0], "unit": "score", "name": "ai-astar", "value": 127.5}, {"lowerIsBetter": true, "replicates": [152.0, 124.0, 144.0, 154.0, 122.0, 142.0, 142.0, 122.0, 156.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 138.1}, {"lowerIsBetter": true, "replicates": [195.0, 193.0, 202.0, 201.0, 204.0, 230.0, 197.0, 203.0, 202.0, 200.0], "unit": "score", "name": "audio-dft", "value": 202.7}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 77.0, 105.0, 57.0, 57.0, 62.0, 67.0, 117.0, 57.0], "unit": "score", "name": "audio-fft", "value": 73.5}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 116.0, 79.0, 81.0, 86.0, 113.0, 78.0, 80.0, 113.0], "unit": "score", "name": "audio-oscillator", "value": 91.1}, {"lowerIsBetter": true, "replicates": [103.0, 141.0, 130.0, 107.0, 129.0, 140.0, 87.0, 80.0, 75.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.8}, {"lowerIsBetter": true, "replicates": [103.0, 95.0, 110.0, 120.0, 91.0, 154.0, 154.0, 121.0, 108.0, 152.0], "unit": "score", "name": "imaging-darkroom", "value": 120.8}, {"lowerIsBetter": true, "replicates": [147.0, 149.0, 93.0, 131.0, 147.0, 91.0, 91.0, 92.0, 91.0, 138.0], "unit": "score", "name": "imaging-desaturate", "value": 117.0}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 54.0, 55.0, 54.0, 57.0, 57.0, 73.0, 70.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 60.1}, {"lowerIsBetter": true, "replicates": [60.0, 68.0, 65.0, 64.0, 78.0, 73.0, 68.0, 81.0, 99.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 72.2}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 83.0, 89.0, 87.0, 83.0, 87.0, 86.0, 86.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.1}, {"lowerIsBetter": true, "replicates": [137.0, 128.0, 129.0, 134.0, 125.0, 131.0, 124.0, 117.0, 147.0, 136.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.8}, {"lowerIsBetter": true, "replicates": [139.0, 141.0, 143.0, 145.0, 139.0, 153.0, 175.0, 181.0, 168.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.4}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 66.0, 68.0, 69.0, 68.0, 67.0, 68.0, 67.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1549.8}]} 01:29:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1549.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7456.31"}}} 01:29:03 INFO - Return code: 0 01:29:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:29:03 ERROR - # TBPL SUCCESS # 01:29:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:29:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:29:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:29:03 INFO - 2016-02-25 01:29:03.118 screenresolution[1695:10585] starting screenresolution argv=screenresolution get 01:29:03 INFO - 2016-02-25 01:29:03.121 screenresolution[1695:10585] Display 0: 1600x1200x32@60 01:29:03 INFO - 2016-02-25 01:29:03.127 screenresolution[1696:10588] starting screenresolution argv=screenresolution list 01:29:03 INFO - Available Modes on Display 0 01:29:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:29:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:29:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:29:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:29:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:29:03 INFO - Intel Iris: 01:29:03 INFO - Chipset Model: Intel Iris 01:29:03 INFO - Type: GPU 01:29:03 INFO - Bus: Built-In 01:29:03 INFO - VRAM (Dynamic, Max): 1536 MB 01:29:03 INFO - Vendor: Intel (0x8086) 01:29:03 INFO - Device ID: 0x0a2e 01:29:03 INFO - Revision ID: 0x0009 01:29:03 INFO - Displays: 01:29:03 INFO - Display: 01:29:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:29:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:29:03 INFO - Display Serial Number: 1600x1200 60 01:29:03 INFO - Main Display: Yes 01:29:03 INFO - Mirror: Off 01:29:03 INFO - Online: Yes 01:29:03 INFO - Rotation: Supported 01:29:03 INFO - Return code: 0 01:29:03 INFO - Running post-action listener: _resource_record_post_action 01:29:03 INFO - Running post-run listener: _resource_record_post_run 01:29:04 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 33984000; Write bytes: 711608320; Read time: 355; Write time: 1995 01:29:04 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 391211520; Write bytes: 385816064; Read time: 29644; Write time: 738 01:29:04 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 33041920; Write bytes: 304583168; Read time: 340; Write time: 1209 01:29:04 INFO - Running post-run listener: _upload_blobber_files 01:29:04 INFO - Blob upload gear active. 01:29:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:29:04 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 01:29:04 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'] 01:29:04 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 01:29:04 INFO - (blobuploader) - INFO - Open directory for files ... 01:29:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:29:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:29:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:29:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:29:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:29:05 INFO - (blobuploader) - INFO - Done attempting. 01:29:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:29:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:29:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:29:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:29:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:29:06 INFO - (blobuploader) - INFO - Done attempting. 01:29:06 INFO - (blobuploader) - INFO - Iteration through files over. 01:29:06 INFO - Return code: 0 01:29:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:29:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:29:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/866a29daf8a149254eee4b3d001752d655975443766ff9f4f270b5eb905b2c4dfc60e46403eec07daa6d32bc2413865ebbc2798c9645e711bcbbd675882819b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a5295fab97212402c1461e13e9ca1fc6d8c037f084d8f2c552ccd588ba266b67ea0667e8edd930b55c10573028cee38c2ee88f5a472405189fbb0f135415683"} 01:29:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:29:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:29:06 INFO - Contents: 01:29:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/866a29daf8a149254eee4b3d001752d655975443766ff9f4f270b5eb905b2c4dfc60e46403eec07daa6d32bc2413865ebbc2798c9645e711bcbbd675882819b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a5295fab97212402c1461e13e9ca1fc6d8c037f084d8f2c552ccd588ba266b67ea0667e8edd930b55c10573028cee38c2ee88f5a472405189fbb0f135415683"} 01:29:06 INFO - Running post-run listener: copy_logs_to_upload_dir 01:29:06 INFO - Copying logs to upload dir... 01:29:06 INFO - mkdir: /builds/slave/test/build/upload/logs 01:29:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.668324 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-02-25 01:29:06.511001) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 01:29:06.514388) ========= 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.w9LTi7Zah1/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.e1L2B5otke/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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/866a29daf8a149254eee4b3d001752d655975443766ff9f4f270b5eb905b2c4dfc60e46403eec07daa6d32bc2413865ebbc2798c9645e711bcbbd675882819b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a5295fab97212402c1461e13e9ca1fc6d8c037f084d8f2c552ccd588ba266b67ea0667e8edd930b55c10573028cee38c2ee88f5a472405189fbb0f135415683"} build_url:https://queue.taskcluster.net/v1/task/TpvVPTkXQRupUvVME-NKRA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011519 build_url: 'https://queue.taskcluster.net/v1/task/TpvVPTkXQRupUvVME-NKRA/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/866a29daf8a149254eee4b3d001752d655975443766ff9f4f270b5eb905b2c4dfc60e46403eec07daa6d32bc2413865ebbc2798c9645e711bcbbd675882819b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a5295fab97212402c1461e13e9ca1fc6d8c037f084d8f2c552ccd588ba266b67ea0667e8edd930b55c10573028cee38c2ee88f5a472405189fbb0f135415683"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 01:29:06.542268) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:29:06.542605) ========= 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.w9LTi7Zah1/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.e1L2B5otke/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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.005079 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:29:06.590980) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 01:29:06.591317) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 01:29:06.591744) ========= ========= Total master_lag: 42.32 =========