builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0158 starttime: 1456477199.57 results: success (0) buildid: 20160226000943 builduid: 40c12cc108a9441486c516af198d6348 revision: a97d22a2418febbac21e5f6117046a3d739d5c5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 00:59:59.574868) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 00:59:59.575422) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 00:59:59.575757) ========= 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.7s78tnYoyA/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.2BYoyqWfig/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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.005506 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 00:59:59.647141) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 00:59:59.647501) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 00:59:59.964302) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 00:59:59.964594) ========= 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.7s78tnYoyA/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.2BYoyqWfig/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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.005488 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 01:00:00.013024) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 01:00:00.013329) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 01:00:00.013714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 01:00:00.014046) ========= 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.7s78tnYoyA/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.2BYoyqWfig/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-26 01:00:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.9M=0.001s 2016-02-26 01:00:00 (15.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.641609 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 01:00:00.697480) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 01:00:00.697857) ========= 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.7s78tnYoyA/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.2BYoyqWfig/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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.026422 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 01:00:00.764823) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-26 01:00:00.765236) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a97d22a2418febbac21e5f6117046a3d739d5c5a --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 a97d22a2418febbac21e5f6117046a3d739d5c5a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7s78tnYoyA/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.2BYoyqWfig/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-26 01:00:00,864 truncating revision to first 12 chars 2016-02-26 01:00:00,864 Setting DEBUG logging. 2016-02-26 01:00:00,865 attempt 1/10 2016-02-26 01:00:00,865 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a97d22a2418f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-26 01:00:01,628 unpacking tar archive at: fx-team-a97d22a2418f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.999032 ========= master_lag: 0.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-26 01:00:01.939201) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 01:00:01.939666) ========= echo a97d22a2418febbac21e5f6117046a3d739d5c5a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a97d22a2418febbac21e5f6117046a3d739d5c5a'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7s78tnYoyA/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.2BYoyqWfig/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 a97d22a2418febbac21e5f6117046a3d739d5c5a program finished with exit code 0 elapsedTime=0.005833 script_repo_revision: 'a97d22a2418febbac21e5f6117046a3d739d5c5a' ========= master_lag: 0.33 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 01:00:02.274808) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 01:00:02.275127) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 01:00:02.747037) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-02-26 01:00:02.747365) ========= /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.7s78tnYoyA/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.2BYoyqWfig/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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:00:02 INFO - MultiFileLogger online at 20160226 01:00:02 in /builds/slave/test 01:00:02 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:00:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:00:02 INFO - {'append_to_log': False, 01:00:02 INFO - 'base_work_dir': '/builds/slave/test', 01:00:02 INFO - 'blob_upload_branch': 'Fx-Team', 01:00:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:00:02 INFO - 'branch': 'Fx-Team', 01:00:02 INFO - 'buildbot_json_path': 'buildprops.json', 01:00:02 INFO - 'config_files': ('talos/mac_config.py',), 01:00:02 INFO - 'default_actions': ('clobber', 01:00:02 INFO - 'read-buildbot-config', 01:00:02 INFO - 'download-and-extract', 01:00:02 INFO - 'populate-webroot', 01:00:02 INFO - 'create-virtualenv', 01:00:02 INFO - 'install', 01:00:02 INFO - 'run-tests'), 01:00:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:00:02 INFO - 'download_minidump_stackwalk': True, 01:00:02 INFO - 'download_symbols': 'ondemand', 01:00:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:00:02 INFO - 'tooltool.py': '/tools/tooltool.py', 01:00:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:00:02 INFO - '/tools/misc-python/virtualenv.py')}, 01:00:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:00:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:00:02 INFO - 'installer_path': 'installer.exe', 01:00:02 INFO - 'log_level': 'info', 01:00:02 INFO - 'log_name': 'talos', 01:00:02 INFO - 'log_to_console': True, 01:00:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:00:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:00:02 INFO - 'opt_config_files': (), 01:00:02 INFO - 'pip_index': False, 01:00:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:00:02 INFO - 'cmd': ('bash', 01:00:02 INFO - '-c', 01:00:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:00:02 INFO - 'enabled': True, 01:00:02 INFO - 'halt_on_failure': False, 01:00:02 INFO - 'name': 'check_screen_resolution'},), 01:00:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:00:02 INFO - 'cmd': ('bash', 01:00:02 INFO - '-c', 01:00:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:00:02 INFO - 'enabled': True, 01:00:02 INFO - 'halt_on_failure': False, 01:00:02 INFO - 'name': 'check_screen_resolution'},), 01:00:02 INFO - 'run_cmd_checks_enabled': True, 01:00:02 INFO - 'sps_profile': False, 01:00:02 INFO - 'sps_profile_interval': 0, 01:00:02 INFO - 'suite': 'dromaeojs-e10s', 01:00:02 INFO - 'system_bits': '32', 01:00:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:00:02 INFO - 'title': 't-yosemite-r7-0158', 01:00:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:00:02 INFO - 'use_talos_json': True, 01:00:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:00:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:00:02 INFO - 'work_dir': 'build'} 01:00:02 INFO - ##### 01:00:02 INFO - ##### Running clobber step. 01:00:02 INFO - ##### 01:00:02 INFO - Running pre-action listener: _resource_record_pre_action 01:00:02 INFO - Running main action method: clobber 01:00:02 INFO - rmtree: /builds/slave/test/build 01:00:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:00:04 INFO - Running post-action listener: _resource_record_post_action 01:00:04 INFO - ##### 01:00:04 INFO - ##### Running read-buildbot-config step. 01:00:04 INFO - ##### 01:00:04 INFO - Running pre-action listener: _resource_record_pre_action 01:00:04 INFO - Running main action method: read_buildbot_config 01:00:04 INFO - Using buildbot properties: 01:00:04 INFO - { 01:00:04 INFO - "project": "", 01:00:04 INFO - "product": "firefox", 01:00:04 INFO - "script_repo_revision": "production", 01:00:04 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 01:00:04 INFO - "repository": "", 01:00:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 01:00:04 INFO - "buildid": "20160226000943", 01:00:04 INFO - "pgo_build": "False", 01:00:04 INFO - "basedir": "/builds/slave/test", 01:00:04 INFO - "buildnumber": 455, 01:00:04 INFO - "slavename": "t-yosemite-r7-0158", 01:00:04 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 01:00:04 INFO - "platform": "yosemite_r7", 01:00:04 INFO - "scheduler": "tests-fx-team-macosx64-talos", 01:00:04 INFO - "branch": "fx-team", 01:00:04 INFO - "repo_path": "integration/fx-team", 01:00:04 INFO - "revision": "a97d22a2418febbac21e5f6117046a3d739d5c5a", 01:00:04 INFO - "stage_platform": "macosx64", 01:00:04 INFO - "builduid": "40c12cc108a9441486c516af198d6348", 01:00:04 INFO - "slavebuilddir": "test" 01:00:04 INFO - } 01:00:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 01:00:04 INFO - Running post-action listener: _resource_record_post_action 01:00:04 INFO - ##### 01:00:04 INFO - ##### Running download-and-extract step. 01:00:04 INFO - ##### 01:00:04 INFO - Running pre-action listener: _resource_record_pre_action 01:00:04 INFO - Running main action method: download_and_extract 01:00:04 INFO - mkdir: /builds/slave/test/build/tests 01:00:04 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:00:04 INFO - https://queue.taskcluster.net/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:00:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/test_packages.json 01:00:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/test_packages.json 01:00:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 01:00:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 01:00:07 INFO - Downloaded 1277 bytes. 01:00:07 INFO - Reading from file /builds/slave/test/build/test_packages.json 01:00:07 INFO - Using the following test package requirements: 01:00:07 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:00:07 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:00:07 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 01:00:07 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:00:07 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 01:00:07 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:00:07 INFO - u'jsshell-mac.zip'], 01:00:07 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:00:07 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 01:00:07 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:00:07 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:00:07 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 01:00:07 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:00:07 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 01:00:07 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:00:07 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 01:00:07 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:00:07 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:00:07 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 01:00:07 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:00: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:00:07 INFO - https://queue.taskcluster.net/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:00:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:00:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:00:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpXnOptXRHiB9cYkajRKJQ/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:00:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpXnOptXRHiB9cYkajRKJQ/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:00:09 INFO - Downloaded 17830419 bytes. 01:00:09 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:00:09 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:00:12 INFO - Return code: 0 01:00:12 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:00: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:00:12 INFO - https://queue.taskcluster.net/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:00:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:00:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:00:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpXnOptXRHiB9cYkajRKJQ/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:00:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpXnOptXRHiB9cYkajRKJQ/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:00:14 INFO - Downloaded 17830419 bytes. 01:00:14 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:00:14 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:00:17 INFO - Return code: 0 01:00:17 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:00:17 INFO - https://queue.taskcluster.net/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:00:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:00:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:00:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpXnOptXRHiB9cYkajRKJQ/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:00:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpXnOptXRHiB9cYkajRKJQ/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:00:18 INFO - Downloaded 10713410 bytes. 01:00:18 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:00:18 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:00:19 INFO - Return code: 0 01:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:19 INFO - https://queue.taskcluster.net/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:00:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:00:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:00:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 01:00:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpXnOptXRHiB9cYkajRKJQ/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:00:26 INFO - Downloaded 111439516 bytes. 01:00:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:00:26 INFO - mkdir: /builds/slave/test/properties 01:00:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:00:26 INFO - Writing to file /builds/slave/test/properties/build_url 01:00:26 INFO - Contents: 01:00:26 INFO - build_url:https://queue.taskcluster.net/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:00:26 INFO - Running post-action listener: _resource_record_post_action 01:00:26 INFO - Running post-action listener: set_extra_try_arguments 01:00:26 INFO - ##### 01:00:26 INFO - ##### Running populate-webroot step. 01:00:26 INFO - ##### 01:00:26 INFO - Running pre-action listener: _resource_record_pre_action 01:00:26 INFO - Running main action method: populate_webroot 01:00:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:00:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:00:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:00:26 INFO - '--tppagecycles', 01:00:26 INFO - '7'], 01:00:26 INFO - 'tests': ['tsvgm']}}, 01:00:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:00:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:00:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:00:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:00:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:00:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:00:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:00:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:26 INFO - 'talos_options': ['--e10s'], 01:00:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:00:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:26 INFO - 'tests': ['damp', 'tps']}, 01:00:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:26 INFO - 'talos_options': ['--e10s'], 01:00:26 INFO - 'tests': ['damp', 'tps']}, 01:00:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:00:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:00:26 INFO - 'other': {'tests': ['a11yr', 01:00:26 INFO - 'ts_paint', 01:00:26 INFO - 'tpaint', 01:00:26 INFO - 'sessionrestore', 01:00:26 INFO - 'sessionrestore_no_auto_restore']}, 01:00:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:00:26 INFO - 'tests': ['a11yr', 01:00:26 INFO - 'ts_paint', 01:00:26 INFO - 'tpaint', 01:00:26 INFO - 'sessionrestore', 01:00:26 INFO - 'sessionrestore_no_auto_restore']}, 01:00:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:00:26 INFO - 'tests': ['a11yr', 01:00:26 INFO - 'ts_paint', 01:00:26 INFO - 'tpaint', 01:00:26 INFO - 'sessionrestore', 01:00:26 INFO - 'sessionrestore_no_auto_restore']}, 01:00:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:00:26 INFO - 'tests': ['a11yr', 01:00:26 INFO - 'ts_paint', 01:00:26 INFO - 'tpaint', 01:00:26 INFO - 'sessionrestore', 01:00:26 INFO - 'sessionrestore_no_auto_restore']}, 01:00:26 INFO - 'other_l64': {'tests': ['a11yr', 01:00:26 INFO - 'ts_paint', 01:00:26 INFO - 'tpaint', 01:00:26 INFO - 'sessionrestore', 01:00:26 INFO - 'sessionrestore_no_auto_restore']}, 01:00:26 INFO - 'other_nol64': {'tests': ['a11yr', 01:00:26 INFO - 'ts_paint', 01:00:26 INFO - 'tpaint', 01:00:26 INFO - 'sessionrestore', 01:00:26 INFO - 'sessionrestore_no_auto_restore']}, 01:00:26 INFO - 'svgr': {'tests': ['tsvgx', 01:00:26 INFO - 'tsvgr_opacity', 01:00:26 INFO - 'tart', 01:00:26 INFO - 'tscrollx', 01:00:26 INFO - 'cart']}, 01:00:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:00:26 INFO - 'tests': ['tsvgx', 01:00:26 INFO - 'tsvgr_opacity', 01:00:26 INFO - 'tart', 01:00:26 INFO - 'tscrollx', 01:00:26 INFO - 'cart']}, 01:00:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:26 INFO - 'tests': ['tp5o']}, 01:00:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:26 INFO - 'talos_options': ['--e10s'], 01:00:26 INFO - 'tests': ['tp5o']}, 01:00:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:26 INFO - 'talos_options': ['--xperf_path', 01:00:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:00:26 INFO - 'tests': ['tp5n']}, 01:00:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:26 INFO - 'talos_options': ['--e10s', 01:00:26 INFO - '--xperf_path', 01:00:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:00:26 INFO - 'tests': ['tp5n']}}, 01:00:26 INFO - 'talos.zip': {'path': '', 01:00:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:00:26 INFO - Running post-action listener: _resource_record_post_action 01:00:26 INFO - ##### 01:00:26 INFO - ##### Running create-virtualenv step. 01:00:26 INFO - ##### 01:00:26 INFO - Running pre-action listener: _resource_record_pre_action 01:00:26 INFO - Running main action method: create_virtualenv 01:00:26 INFO - Creating virtualenv /builds/slave/test/build/venv 01:00:26 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:00:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:00:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:00:27 INFO - Using real prefix '/tools/python27' 01:00:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:00:27 INFO - Installing distribute.............................................................................................................................................................................................done. 01:00:30 INFO - Installing pip.................done. 01:00:30 INFO - Return code: 0 01:00:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:30 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 0x1037afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96e2460e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103653d30>, '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 0x103477db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10364ab20>, '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.7s78tnYoyA/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.2BYoyqWfig/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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:00:30 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:00:30 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:00:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7s78tnYoyA/Render', 01:00:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:30 INFO - 'HOME': '/Users/cltbld', 01:00:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:30 INFO - 'LOGNAME': 'cltbld', 01:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:30 INFO - 'MOZ_NO_REMOTE': '1', 01:00:30 INFO - 'NO_EM_RESTART': '1', 01:00:30 INFO - 'PAGER': '/bin/cat', 01:00:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:30 INFO - 'PWD': '/builds/slave/test', 01:00:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:30 INFO - 'SHELL': '/bin/bash', 01:00:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2BYoyqWfig/Listeners', 01:00:30 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 01:00:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:30 INFO - 'USER': 'cltbld', 01:00:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:30 INFO - 'XPC_FLAGS': '0x0', 01:00:30 INFO - 'XPC_SERVICE_NAME': '0', 01:00:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:30 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:00:30 INFO - Cleaning up... 01:00:30 INFO - Return code: 0 01:00:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:30 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 0x1037afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96e2460e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103653d30>, '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 0x103477db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10364ab20>, '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.7s78tnYoyA/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.2BYoyqWfig/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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:00:30 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:00:30 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:00:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7s78tnYoyA/Render', 01:00:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:30 INFO - 'HOME': '/Users/cltbld', 01:00:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:30 INFO - 'LOGNAME': 'cltbld', 01:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:30 INFO - 'MOZ_NO_REMOTE': '1', 01:00:30 INFO - 'NO_EM_RESTART': '1', 01:00:30 INFO - 'PAGER': '/bin/cat', 01:00:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:30 INFO - 'PWD': '/builds/slave/test', 01:00:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:30 INFO - 'SHELL': '/bin/bash', 01:00:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2BYoyqWfig/Listeners', 01:00:30 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 01:00:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:30 INFO - 'USER': 'cltbld', 01:00:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:30 INFO - 'XPC_FLAGS': '0x0', 01:00:30 INFO - 'XPC_SERVICE_NAME': '0', 01:00:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:31 INFO - Downloading/unpacking psutil>=0.7.1 01:00: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:00: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:00: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:00: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:00: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:00: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:00:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:00:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:00:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:00:34 INFO - Installing collected packages: psutil 01:00:34 INFO - Running setup.py install for psutil 01:00:34 INFO - building 'psutil._psutil_osx' extension 01:00:34 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:00:35 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:00:35 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:00:35 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:00:35 INFO - building 'psutil._psutil_posix' extension 01:00:35 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:00:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:00:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:00:35 INFO - ^ 01:00:35 INFO - 1 warning generated. 01:00:35 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:00:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:00:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:00:35 INFO - Successfully installed psutil 01:00:35 INFO - Cleaning up... 01:00:35 INFO - Return code: 0 01:00:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:35 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 0x1037afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96e2460e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103653d30>, '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 0x103477db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10364ab20>, '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.7s78tnYoyA/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.2BYoyqWfig/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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:00:35 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:00:35 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:00:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7s78tnYoyA/Render', 01:00:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:35 INFO - 'HOME': '/Users/cltbld', 01:00:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:35 INFO - 'LOGNAME': 'cltbld', 01:00:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:35 INFO - 'MOZ_NO_REMOTE': '1', 01:00:35 INFO - 'NO_EM_RESTART': '1', 01:00:35 INFO - 'PAGER': '/bin/cat', 01:00:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:35 INFO - 'PWD': '/builds/slave/test', 01:00:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:35 INFO - 'SHELL': '/bin/bash', 01:00:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2BYoyqWfig/Listeners', 01:00:35 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 01:00:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:35 INFO - 'USER': 'cltbld', 01:00:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:35 INFO - 'XPC_FLAGS': '0x0', 01:00:35 INFO - 'XPC_SERVICE_NAME': '0', 01:00:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:00:36 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:00:36 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:00:36 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:00:36 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:00:36 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:00:36 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:00:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:00:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:00:38 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:00:38 INFO - Installing collected packages: mozsystemmonitor 01:00:38 INFO - Running setup.py install for mozsystemmonitor 01:00:38 INFO - Successfully installed mozsystemmonitor 01:00:38 INFO - Cleaning up... 01:00:38 INFO - Return code: 0 01:00:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:38 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 0x1037afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96e2460e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103653d30>, '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 0x103477db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10364ab20>, '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.7s78tnYoyA/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.2BYoyqWfig/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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:00:38 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:00:38 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:00:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7s78tnYoyA/Render', 01:00:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:38 INFO - 'HOME': '/Users/cltbld', 01:00:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:38 INFO - 'LOGNAME': 'cltbld', 01:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:38 INFO - 'MOZ_NO_REMOTE': '1', 01:00:38 INFO - 'NO_EM_RESTART': '1', 01:00:38 INFO - 'PAGER': '/bin/cat', 01:00:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:38 INFO - 'PWD': '/builds/slave/test', 01:00:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:38 INFO - 'SHELL': '/bin/bash', 01:00:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2BYoyqWfig/Listeners', 01:00:38 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 01:00:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:38 INFO - 'USER': 'cltbld', 01:00:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:38 INFO - 'XPC_FLAGS': '0x0', 01:00:38 INFO - 'XPC_SERVICE_NAME': '0', 01:00:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:38 INFO - Downloading/unpacking blobuploader==1.2.4 01:00:38 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:00:38 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:00:38 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:00:38 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:00:38 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:00:38 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:00:41 INFO - Downloading blobuploader-1.2.4.tar.gz 01:00:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:00:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:00:41 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:00:41 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:00:41 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:00:41 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:00:41 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:00:41 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:00:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:00:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:00:41 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:00:41 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:00:41 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:00:41 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:00:41 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:00:41 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:00:42 INFO - Downloading docopt-0.6.1.tar.gz 01:00:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:00:42 INFO - Installing collected packages: blobuploader, requests, docopt 01:00:42 INFO - Running setup.py install for blobuploader 01:00:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:00:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:00:42 INFO - Running setup.py install for requests 01:00:43 INFO - Running setup.py install for docopt 01:00:43 INFO - Successfully installed blobuploader requests docopt 01:00:43 INFO - Cleaning up... 01:00:43 INFO - Return code: 0 01:00:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:00: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:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00: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:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:43 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 0x1037afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96e2460e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103653d30>, '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 0x103477db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10364ab20>, '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.7s78tnYoyA/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.2BYoyqWfig/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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:00:43 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:00:43 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:00:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7s78tnYoyA/Render', 01:00:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:43 INFO - 'HOME': '/Users/cltbld', 01:00:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:43 INFO - 'LOGNAME': 'cltbld', 01:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:43 INFO - 'MOZ_NO_REMOTE': '1', 01:00:43 INFO - 'NO_EM_RESTART': '1', 01:00:43 INFO - 'PAGER': '/bin/cat', 01:00:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:43 INFO - 'PWD': '/builds/slave/test', 01:00:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:43 INFO - 'SHELL': '/bin/bash', 01:00:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2BYoyqWfig/Listeners', 01:00:43 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 01:00:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:43 INFO - 'USER': 'cltbld', 01:00:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:43 INFO - 'XPC_FLAGS': '0x0', 01:00:43 INFO - 'XPC_SERVICE_NAME': '0', 01:00:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:00:43 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-9Ihoy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:00:43 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-rJJXu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:00:43 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-29ZjvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:00:43 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-Hhfj9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:00:44 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-izfXa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:00:44 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-hlW5zb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:00:44 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-tLsOpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:00:44 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-0XhEv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:00:44 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-knWnpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:00:44 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-qZBOvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:00:44 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-y_Sois-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:00:44 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-Hmsb4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:00:44 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-bdnBfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:00:44 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-ziCIjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:45 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-p9AJTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:00:45 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-nHPyxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:00:45 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-TYJCjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:00:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:00:45 INFO - Running setup.py install for manifestparser 01:00:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:00:45 INFO - Running setup.py install for mozcrash 01:00:45 INFO - Running setup.py install for mozdebug 01:00:45 INFO - Running setup.py install for mozdevice 01:00:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:00:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:00:46 INFO - Running setup.py install for mozfile 01:00:46 INFO - Running setup.py install for mozhttpd 01:00:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:00:46 INFO - Running setup.py install for mozinfo 01:00:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:00:46 INFO - Running setup.py install for mozInstall 01:00:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:00:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:00:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:00:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:00:46 INFO - Running setup.py install for mozleak 01:00:46 INFO - Running setup.py install for mozlog 01:00:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:00:46 INFO - Running setup.py install for moznetwork 01:00:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:00:47 INFO - Running setup.py install for mozprocess 01:00:47 INFO - Running setup.py install for mozprofile 01:00:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:00:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:00:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:00:47 INFO - Running setup.py install for mozrunner 01:00:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:00:47 INFO - Running setup.py install for mozscreenshot 01:00:47 INFO - Running setup.py install for moztest 01:00:47 INFO - Running setup.py install for mozversion 01:00:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:00:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:00:47 INFO - Cleaning up... 01:00:47 INFO - Return code: 0 01:00:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:00:47 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:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:47 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:00:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:47 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 0x1037afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96e2460e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103653d30>, '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 0x103477db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10364ab20>, '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.7s78tnYoyA/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.2BYoyqWfig/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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:00:47 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:00:47 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:00:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7s78tnYoyA/Render', 01:00:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:47 INFO - 'HOME': '/Users/cltbld', 01:00:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:47 INFO - 'LOGNAME': 'cltbld', 01:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:47 INFO - 'MOZ_NO_REMOTE': '1', 01:00:47 INFO - 'NO_EM_RESTART': '1', 01:00:47 INFO - 'PAGER': '/bin/cat', 01:00:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:47 INFO - 'PWD': '/builds/slave/test', 01:00:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:47 INFO - 'SHELL': '/bin/bash', 01:00:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2BYoyqWfig/Listeners', 01:00:47 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 01:00:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:47 INFO - 'USER': 'cltbld', 01:00:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:47 INFO - 'XPC_FLAGS': '0x0', 01:00:47 INFO - 'XPC_SERVICE_NAME': '0', 01:00:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:00:48 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-SJiTlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:00:48 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:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:00:48 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-DZrEjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:00:48 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:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:00:48 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-1cMc8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:00:48 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:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:00:48 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-NdcOHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:00:48 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:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:00:48 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-GgbTL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:00:48 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:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:00:48 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-kXufKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:00:48 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:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:00:48 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-2U84ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:00:48 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:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:00:48 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-87Jo9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:00:49 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:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:00:49 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-eDzc31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:00:49 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:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:00:49 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-fRUKhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:00:49 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:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:00:49 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-DCguoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:00:49 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:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:00:49 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-wMf2Qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:00:49 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:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:00:49 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-IPdMEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:00:49 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:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:00:49 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-kKvlM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:00:49 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:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:49 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-EnS81I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:49 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:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:00:49 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-tbkfup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:00:49 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:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:00:49 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-lco9xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:00:50 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:00:50 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:00:50 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:00:50 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:00:50 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:00:50 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:00:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:00:50 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:00:50 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:00:50 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:00:50 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:00:50 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:00:50 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:00:52 INFO - Downloading blessings-1.6.tar.gz 01:00:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:00:52 INFO - Installing collected packages: blessings 01:00:52 INFO - Running setup.py install for blessings 01:00:52 INFO - Successfully installed blessings 01:00:52 INFO - Cleaning up... 01:00:52 INFO - Return code: 0 01:00:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:00:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:00:53 INFO - Reading from file tmpfile_stdout 01:00:53 INFO - Current package versions: 01:00:53 INFO - blessings == 1.6 01:00:53 INFO - blobuploader == 1.2.4 01:00:53 INFO - docopt == 0.6.1 01:00:53 INFO - manifestparser == 1.1 01:00:53 INFO - mozInstall == 1.12 01:00:53 INFO - mozcrash == 0.16 01:00:53 INFO - mozdebug == 0.1 01:00:53 INFO - mozdevice == 0.48 01:00:53 INFO - mozfile == 1.2 01:00:53 INFO - mozhttpd == 0.7 01:00:53 INFO - mozinfo == 0.9 01:00:53 INFO - mozleak == 0.1 01:00:53 INFO - mozlog == 3.1 01:00:53 INFO - moznetwork == 0.27 01:00:53 INFO - mozprocess == 0.22 01:00:53 INFO - mozprofile == 0.28 01:00:53 INFO - mozrunner == 6.11 01:00:53 INFO - mozscreenshot == 0.1 01:00:53 INFO - mozsystemmonitor == 0.0 01:00:53 INFO - moztest == 0.7 01:00:53 INFO - mozversion == 1.4 01:00:53 INFO - psutil == 3.1.1 01:00:53 INFO - requests == 1.2.3 01:00:53 INFO - wsgiref == 0.1.2 01:00:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:53 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 0x1037afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96e2460e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103653d30>, '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 0x103477db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10364ab20>, '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.7s78tnYoyA/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.2BYoyqWfig/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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:00:53 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:00:53 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:00:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7s78tnYoyA/Render', 01:00:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:53 INFO - 'HOME': '/Users/cltbld', 01:00:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:53 INFO - 'LOGNAME': 'cltbld', 01:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:53 INFO - 'MOZ_NO_REMOTE': '1', 01:00:53 INFO - 'NO_EM_RESTART': '1', 01:00:53 INFO - 'PAGER': '/bin/cat', 01:00:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:53 INFO - 'PWD': '/builds/slave/test', 01:00:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:53 INFO - 'SHELL': '/bin/bash', 01:00:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2BYoyqWfig/Listeners', 01:00:53 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 01:00:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:53 INFO - 'USER': 'cltbld', 01:00:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:53 INFO - 'XPC_FLAGS': '0x0', 01:00:53 INFO - 'XPC_SERVICE_NAME': '0', 01:00:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:53 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:00:53 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:00:53 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:00:53 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:00:53 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:00:53 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:00:53 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:00:53 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:00:53 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:00:53 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:00:53 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:00:53 INFO - Cleaning up... 01:00:53 INFO - Return code: 0 01:00:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:53 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 0x1037afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96e2460e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103653d30>, '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 0x103477db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10364ab20>, '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.7s78tnYoyA/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.2BYoyqWfig/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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:00:53 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:00:53 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:00:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7s78tnYoyA/Render', 01:00:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:53 INFO - 'HOME': '/Users/cltbld', 01:00:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:53 INFO - 'LOGNAME': 'cltbld', 01:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:53 INFO - 'MOZ_NO_REMOTE': '1', 01:00:53 INFO - 'NO_EM_RESTART': '1', 01:00:53 INFO - 'PAGER': '/bin/cat', 01:00:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:53 INFO - 'PWD': '/builds/slave/test', 01:00:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:53 INFO - 'SHELL': '/bin/bash', 01:00:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2BYoyqWfig/Listeners', 01:00:53 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 01:00:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:53 INFO - 'USER': 'cltbld', 01:00:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:53 INFO - 'XPC_FLAGS': '0x0', 01:00:53 INFO - 'XPC_SERVICE_NAME': '0', 01:00:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:53 INFO - Downloading/unpacking jsonschema 01:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:00:55 INFO - Downloading/unpacking functools32 (from jsonschema) 01:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:56 INFO - Downloading functools32-3.2.3-2.tar.gz 01:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:00:56 INFO - warning: no files found matching '*.txt' 01:00:56 INFO - no previously-included directories found matching 'build' 01:00:56 INFO - no previously-included directories found matching 'dist' 01:00:56 INFO - no previously-included directories found matching '.git*' 01:00:56 INFO - Installing collected packages: jsonschema, functools32 01:00:56 INFO - Running setup.py install for functools32 01:00:56 INFO - warning: no files found matching '*.txt' 01:00:56 INFO - no previously-included directories found matching 'build' 01:00:56 INFO - no previously-included directories found matching 'dist' 01:00:56 INFO - no previously-included directories found matching '.git*' 01:00:56 INFO - Successfully installed jsonschema functools32 01:00:56 INFO - Cleaning up... 01:00:56 INFO - Return code: 0 01:00:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1037afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96e2460e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103653d30>, '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 0x103477db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10364ab20>, '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.7s78tnYoyA/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.2BYoyqWfig/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:00:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7s78tnYoyA/Render', 01:00:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:56 INFO - 'HOME': '/Users/cltbld', 01:00:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:56 INFO - 'LOGNAME': 'cltbld', 01:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:56 INFO - 'MOZ_NO_REMOTE': '1', 01:00:56 INFO - 'NO_EM_RESTART': '1', 01:00:56 INFO - 'PAGER': '/bin/cat', 01:00:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:56 INFO - 'PWD': '/builds/slave/test', 01:00:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:56 INFO - 'SHELL': '/bin/bash', 01:00:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2BYoyqWfig/Listeners', 01:00:56 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 01:00:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:56 INFO - 'USER': 'cltbld', 01:00:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:56 INFO - 'XPC_FLAGS': '0x0', 01:00:56 INFO - 'XPC_SERVICE_NAME': '0', 01:00:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:56 INFO - Downloading/unpacking flake8 01:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:00:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:00:59 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:00:59 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:00:59 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:00:59 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:00:59 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:00:59 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:00:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:00:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:00:59 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:00:59 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:00:59 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:00:59 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:00:59 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:00:59 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:01:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:01:00 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:01:00 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:01:00 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:01:00 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:01:00 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:01:00 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:01:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:01:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:01:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:01:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:01:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:01:00 INFO - no previously-included directories found matching 'docs/_build' 01:01:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:01:00 INFO - Running setup.py install for pep8 01:01:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:01:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:01:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:01:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:01:00 INFO - no previously-included directories found matching 'docs/_build' 01:01:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:01:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:01:00 INFO - Cleaning up... 01:01:00 INFO - Return code: 0 01:01:00 INFO - Running post-action listener: _resource_record_post_action 01:01:00 INFO - Running post-action listener: _start_resource_monitoring 01:01:00 INFO - Starting resource monitoring. 01:01:00 INFO - ##### 01:01:00 INFO - ##### Running install step. 01:01:00 INFO - ##### 01:01:00 INFO - Running pre-action listener: _resource_record_pre_action 01:01:00 INFO - Running main action method: install 01:01:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:01:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:01:01 INFO - Reading from file tmpfile_stdout 01:01:01 INFO - Detecting whether we're running mozinstall >=1.0... 01:01:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:01:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:01:01 INFO - Reading from file tmpfile_stdout 01:01:01 INFO - Output received: 01:01:01 INFO - Usage: mozinstall [options] installer 01:01:01 INFO - Options: 01:01:01 INFO - -h, --help show this help message and exit 01:01:01 INFO - -d DEST, --destination=DEST 01:01:01 INFO - Directory to install application into. [default: 01:01:01 INFO - "/builds/slave/test"] 01:01:01 INFO - --app=APP Application being installed. [default: firefox] 01:01:01 INFO - mkdir: /builds/slave/test/build/application 01:01:01 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:01:01 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:01:35 INFO - Reading from file tmpfile_stdout 01:01:35 INFO - Output received: 01:01:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:01:35 INFO - Running post-action listener: _resource_record_post_action 01:01:35 INFO - ##### 01:01:35 INFO - ##### Running run-tests step. 01:01:35 INFO - ##### 01:01:35 INFO - Running pre-action listener: _resource_record_pre_action 01:01:35 INFO - Running main action method: run_tests 01:01:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:01:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:01:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:01:35 INFO - 2016-02-26 01:01:35.143 screenresolution[1659:7961] starting screenresolution argv=screenresolution get 01:01:35 INFO - 2016-02-26 01:01:35.145 screenresolution[1659:7961] Display 0: 1600x1200x32@60 01:01:35 INFO - 2016-02-26 01:01:35.151 screenresolution[1660:7963] starting screenresolution argv=screenresolution list 01:01:35 INFO - Available Modes on Display 0 01:01:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:01:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:01:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:01:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:01:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:01:35 INFO - Intel Iris: 01:01:35 INFO - Chipset Model: Intel Iris 01:01:35 INFO - Type: GPU 01:01:35 INFO - Bus: Built-In 01:01:35 INFO - VRAM (Dynamic, Max): 1536 MB 01:01:35 INFO - Vendor: Intel (0x8086) 01:01:35 INFO - Device ID: 0x0a2e 01:01:35 INFO - Revision ID: 0x0009 01:01:35 INFO - Displays: 01:01:35 INFO - Display: 01:01:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:01:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:01:35 INFO - Display Serial Number: 1600x1200 60 01:01:35 INFO - Main Display: Yes 01:01:35 INFO - Mirror: Off 01:01:35 INFO - Online: Yes 01:01:35 INFO - Rotation: Supported 01:01:35 INFO - Return code: 0 01:01:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:01:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:01:35 INFO - Python 2.7.3 01:01:35 INFO - Return code: 0 01:01:35 INFO - grabbing minidump binary from tooltool 01:01:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:01:35 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 0x103653d30>, '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 0x103477db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10364ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:01:35 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:01:35 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:01:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:01:35 INFO - Return code: 0 01:01:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:01:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:01:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:01:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:01:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:01:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:01:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:01:36 INFO - Return code: 0 01:01:36 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/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0158', '--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:01:36 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/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0158 --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:01:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7s78tnYoyA/Render', 01:01:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:01:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:01:36 INFO - 'HOME': '/Users/cltbld', 01:01:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:01:36 INFO - 'LOGNAME': 'cltbld', 01:01:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:01:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:01:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:36 INFO - 'MOZ_NO_REMOTE': '1', 01:01:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:01:36 INFO - 'NO_EM_RESTART': '1', 01:01:36 INFO - 'PAGER': '/bin/cat', 01:01:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:01:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:36 INFO - 'PWD': '/builds/slave/test', 01:01:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:01:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:01:36 INFO - 'SHELL': '/bin/bash', 01:01:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2BYoyqWfig/Listeners', 01:01:36 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 01:01:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:01:36 INFO - 'USER': 'cltbld', 01:01:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:01:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:01:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:36 INFO - 'XPC_FLAGS': '0x0', 01:01:36 INFO - 'XPC_SERVICE_NAME': '0', 01:01:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:01:36 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/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0158', '--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:01:36 INFO - mozversion application_buildid: 20160226000943 01:01:36 INFO - mozversion application_changeset: a97d22a2418febbac21e5f6117046a3d739d5c5a 01:01:36 INFO - mozversion application_display_name: Nightly 01:01:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:01:36 INFO - mozversion application_name: Firefox 01:01:36 INFO - mozversion application_remotingname: firefox 01:01:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:01:36 INFO - mozversion application_vendor: Mozilla 01:01:36 INFO - mozversion application_version: 47.0a1 01:01:36 INFO - mozversion platform_buildid: 20160226000943 01:01:36 INFO - mozversion platform_changeset: a97d22a2418febbac21e5f6117046a3d739d5c5a 01:01:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:01:36 INFO - mozversion platform_version: 47.0a1 01:01:36 INFO - using testdate: 1456477296 01:01:36 INFO - actual date: 1456477296 01:01:36 INFO - starting webserver on 'localhost:49282' 01:01:36 INFO - SUITE-START | Running 2 tests 01:01:36 INFO - TEST-START | dromaeo_css 01:01:36 INFO - operating with platform_type : mac_ 01:01:36 INFO - Initialising browser for dromaeo_css test... 01:01:36 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmpeXOnOH/profile http://localhost:49282/getInfo.html) 01:01:39 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 01:01:39 INFO - PROCESS | 1678 | colorDepth:24 01:01:39 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 01:01:39 INFO - PROCESS | 1678 | __metrics 01:01:40 ERROR - PROCESS | 1678 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 01:01:40 INFO - TEST-INFO | 1678: exit 0 01:01:40 INFO - Browser initialized. 01:01:40 INFO - Running cycle 1/1 for dromaeo_css test... 01:01:40 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmpeXOnOH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:01:52 INFO - PROCESS | 1683 | RSS: Main: 255844352 01:01:52 INFO - PROCESS | 1683 | 01:02:42 INFO - PROCESS | 1683 | 1456477362220 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:04:52 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49282/tests/dromaeo/cssquery-ext.html) 01:04:53 INFO - PROCESS | 1683 | RSS: Main: 269549568 01:04:53 INFO - PROCESS | 1683 | 01:07:55 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-ext.html (next: http://localhost:49282/tests/dromaeo/cssquery-jquery.html) 01:07:56 INFO - PROCESS | 1683 | RSS: Main: 281001984 01:07:56 INFO - PROCESS | 1683 | 01:10:58 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49282/tests/dromaeo/cssquery-mootools.html) 01:10:58 INFO - PROCESS | 1683 | RSS: Main: 282210304 01:10:58 INFO - PROCESS | 1683 | 01:14:00 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49282/tests/dromaeo/cssquery-prototype.html) 01:14:01 INFO - PROCESS | 1683 | RSS: Main: 283852800 01:14:01 INFO - PROCESS | 1683 | 01:17:03 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49282/tests/dromaeo/cssquery-yui.html) 01:17:04 INFO - PROCESS | 1683 | RSS: Main: 286019584 01:17:04 INFO - PROCESS | 1683 | 01:20:06 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-yui.html (next: http://localhost:49282/tests/dromaeo/cssquery-dojo.html) 01:20:06 INFO - PROCESS | 1683 | RSS: Main: 288698368 01:20:06 INFO - PROCESS | 1683 | 01:20:06 INFO - PROCESS | 1683 | __start_tp_report 01:20:06 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 01:20:06 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 01:20:06 INFO - PROCESS | 1683 | |i|pagename|runs| 01:20:06 INFO - PROCESS | 1683 | |0;dojo.html;2764.654418197725;3419.81191034493;3456.8444420001097;3528.576570811503;3551.6093229744706;4604.884877878055;5610.214569960209;5665.008623490893;5713.085906255;5727.799527016556;5624.887502249952;5638.295213098363;5741.167530708045;5763.423657634245;5780.306363236417;4904.0927428425675;5118.462561431052;5131.230315452674;5197.298364720752;5257.658252213594;5167.48325167484;5185.092608793465;5201.609879259052;5223.843284701465;5229.633925625208;5005.949940500621;5037.370328708911;5110.2590124431745;5165.974170129125;5220.504052115043;5137.357830271216;5141.974290128525;5143.3313669223135;5145.614078944094;5147.510986456281;5101.591872650179;5123.769430375642;5148.665336753099;5149.716765577892;5175.611829112794;4596.540345965377;4926.0394223126505;5496.917546236809;5614.494695477427;5662.37713851476;6145.262568491765;6152.723127459275;6172.105044768484;6174.135621013062;6198.34917333678;6114.297368146132;6212.502999760009;6222.284437289724;6237.7816776413065;6249.781257656005;5676.489115979541;5725.885482290331;5741.282339707536;5784.95870743266;5786.3056433228285;6237.937620623827;6239.875202496016;6251.249850018027;6269.028300613412;6273;5486.655769336458;5956.106584012433;6102.389761023951;6110.358412366638;6139.140520327158;5661.3206415229615;6033.909491357633;6096.329403765582;6108.144859719643;6118.680093383066;6109.34393638171;6109.6639684817765;6120.204373431515;6171.074338849119;6180.227471566054;6057.42454466825;6200.906986395207;6221.9377806222265;6228.564000520011;6234;4735.360726301974;4840.903181936412;4842.6368022397755;4868.440129385095;4898.559129678346;4330.718503297276;4351.912961740747;4362.498312694081;4382.583654552813;4395.901024743814;5593.636413633101;5716.657000579895;5754;5777.682227477445;5806.65160090396;6169.444749972524;6206.975848984867;6224.37756224374;6239.313675495692;6256.0303153011355;4876.292937524039;5759.020966435716;5778.508826749773;5797.130430435384;5806.622569532967;5190.97404512975;5266.104762190437;5318.627696061239;5328.413874473805;5346.117890548094;4913;4945.381827271663;5284.39229488606;6246.906296405557;6386.489080873612;6218.81343559694;6242.65665388408;6262.46769024638;6268.749250029948;6269.749210031548;6116.214037636738;6176.413240742122;6206.162168107428;6245.125682404558;6299.464545513682;6122.632642041492;6143.72353244114;6162.938370616416;6164.47601953839;6169.629822210682;6114.847128821815;6213.720382582705;6218.844528886814;6224.844378890564;6226.906596401148;5093.796248150181;5521.861953451196;5879.235699359056;5915.349311575809;6010.188624535632;4664.79008444614;5973.283206015306;5993.670348130895;6078.179445774764;6094.969525152346;5790.565707571865;5839.445252700986;5886.23478947734;5896.970515147397;5909.172715819875;5732.742026608896;6006.219191505251;6077.878442431215;6087.634741915322;6132.141500190066;4878.317035615088;5928.466438020599;5931.347551769388;5971.61184523022;5980.252468441445 01:20:06 INFO - PROCESS | 1683 | |1;ext.html;422.97462152270884;451.93672885795985;459.76322194070036;531.2721571447119;591.1280860730426;37441.62558374416;37885.999999999935;38009.809950950206;38123.23753524928;38166.85499435014;38872.611273887254;39411;39543.60456395435;39602;39616.80191599038;9412.964573896867;9672.661456849011;9680.757981050494;9708.951455242714;9712.70861874145;9507.334486585942;9642.035796420338;9649.90350096497;9651.179649729746;9656.324057315991;8175.427720059598;8898.021217666084;9635.421874687507;9664;9693.3699309545;9524.761880952998;9611.423314601112;9619.759506012335;9634.373765705277;9635.759106022371;9466.479343636098;9591.808163836755;9595.23238140947;9620.37467564606;9631.181349585293;36819.631803681885;37385.813070934746;37471.06322341936;37520.43719344212;37666.81166594177;3204.1669166016773;3322.0200040987966;3402.931941361159;3412.744044196695;3770.4721339012285;21961.78038219613;24118.39704007414;27826.84809421499;28345.433091338058;28558.428831423254;2774.209350335145;2782.1236310562313;2848.6724026736983;2854.158023383107;2905.5786910898014;459511;461309;463239.9999999966;464447;465945;44113;63726.68136659287;63745.68127159335;64132;64197.35802642007;35883.82058089693;37959.342846000516;40643.1871362577;43132.137357253305;43439.56560434355;15137.470188543568;15378.923105384401;15401.383944642314;15443.536693899201;15491.845081549265;12162.148649594443;12362.75274494505;12398.388209532703;12509;12509.499620015098;13965.882729381625;14062.859371406155;14393.712125757425;14415.495457658932;14419.42322307096;5288.762005709676;5973.850653733604;6129.467633091727;6148.938510614837;6164.044573091178;924.5839372282366;928.8560273157672;941.8869735631768;1040.33546325878;1063.0857462582173;23747.525049498912;27880.442391152064;28666.71333286682;28871.278218044718;29644.851775740983;1050.1336397472116;1071.78028504158;1074.333912973961;1126.6845283320683;1237.672016915518;14682.779758303634;14812.333444994785;14890.032147910351;15042.548723538312;15404.229788510529;526021.3698931481;529256;532881;533392;534293;53880;55352.72323638356;55668.44331556633;55972;56091.71954140285;1179.4161889864572;1336.1648969394128;1392.2342711508832;1397.0360451288577;1404.6277736399861;28591.85704071466;28882.566761499016;29284.853575731984;29355;29371.7062829369;48889.51110488992;52736.47263527469;53844;53944.73027634837;53952.19071713849;478793;480278;487618;487889;489192;41697.79151104225;42367.36448953207;42743;42946.57053429426;42949.570504294556;41224.587754122076;41390.1721965565;41421;41656.16687666169;42101.36847947344;34415;36840.44739328966;37550.24899502049;38323.616763832004;38402.807985959895;33959.83020084884;34500.48249276212;34504.65495345015;34865.82567087148;35524.28951420906;34926.47610285797;36470.08824779402;37125;37798.43302350522;37989.05027374338;27451.862740686167;29650;33270.83364583162;33339;33603;23842.13209640849;23872.88063559671;24526.754732452446;24846;25408.618870716586 01:20:06 INFO - PROCESS | 1683 | |2;jquery.html;274.5607028753993;351.1221945137157;358.92642008388276;360.4521127885614;367.73339328986503;19423.902880485595;19514.7072793908;20777.85721785303;21074.89462552685;21124.57750844982;17028.829711702878;20117.994100295;20601.690974635392;20641.38075857723;20691.172353105896;5806.506446952004;6090.208272924514;6130.693465326738;6154.138420621094;6159.538034647397;4234.449521562193;5969;6356.2054743157105;6659.433948114416;6680.498962577802;6526.641034743087;6598.406143447089;6608.107905432753;6611.735530578771;6618;6438.806835794933;6587.2095348558005;6590.209174899042;6605.108310378109;6636.867262654744;4791.305260737174;5334.22653715213;5667.404922483162;5696.316442026942;5707.200991861143;13091.214527128403;13272.800907986388;13310.735480129371;13329.466821327136;13330.933345333211;2110.7361579802523;2127.3298910843037;2183.9017244224046;2200.9119635214574;2731.685856126551;9641.807163856683;9884.406935583887;10178.541965611492;14035.01754877159;14461.638459038502;1712.6574685062913;1728.7579738836573;1744.7819022622173;1787.2850859656112;1823.9968017590404;101092;104572;105353.47323263412;105530;106935.93064069415;9919.40483570988;10760.838587421194;10803.351798892092;11059.668209953714;11290.096792256763;13611.659708507168;13681.179129252278;13722.245276509688;13764.105333153313;13781.86218137826;6954.47841411886;8552.786180345416;8596.8710469343;8634.697785577475;8724.214820666171;7191.424686025105;8736.039035706068;8740.519271440131;8767.605457754416;8883.244924181517;3737.2621730895266;4321.438213032348;4483;4524.5701658342405;4534.569215924482;1434.9713005740036;1535.9616009599627;1697.2362436903443;1812.8640351973654;1899.4396652987402;839.9076101628816;884.4737381258141;889.3107841422819;978.8531720242021;1059.9735006624896;18866.811331886507;20106.597868042558;20145.697814532792;20293.957539466697;20360.981950902395;965.971020869375;974.5273542331963;974.6393834281362;1005.0903931941605;1019.3170575714289;10380.792384152426;10565.9471702641;10610.787784244272;10653.89346106529;10654;443873;496165;506708;522943;531617;99943;108290;108558.3716244257;114041.85958140313;117513;816.3346872299176;976.2677991506371;1004.0762498501397;1016.5019140621042;1019.179560453827;13571.1857288563;14440.638984025483;17748.467545973126;17759.289628414717;17825.197866095798;51382.48617513777;52331;52449.737751311;53756;55729;71951;73896;74780;74784;77238;7790.14308426084;7844.797951364834;7893.960530197312;7909.841803164019;7913.129555748748;10518.895515971019;12158.635240942785;12929.806052909025;13294.401751920994;13316.334183290603;11183.161262905152;11183.72040698989;11193.880611938741;11250.718732031764;11661;8988.86516702263;11189.216754827085;11204.887951120385;11423.257488263236;11742.060635149339;9020.774480638036;10906.61826836057;11407.973282404624;11501.137414693763;11818.113641476752;7532.397408207221;8017.318527924958;8156.673733050611;8157.265846073882;8364.456310339809;10863.837042444211;11000.944995274973;11150.386728729998;11159.163062770162;11169.38568378747 01:20:06 INFO - PROCESS | 1683 | |3;mootools.html;1537.9000364976275;1564.8748100151986;1805.8532831651905;1922.0870086708824;1924.894130822804;7812;8420.915790842106;8588.8711669325;8792.329457403097;8830.514321712304;8529.53087580183;8576.927884014498;8675.783105422368;8701.347398945089;8713.520756358397;2297.4600968772324;2299.4366380236825;2300.2409204962323;2321.245595181564;2324.837261391695;2391.6053851114543;2412.457197130649;2469.3579669286023;2475.4306509502735;2475.8638274894874;2434.3427274635837;2446.804255659552;2451.105346548506;2488.154027630605;2492.2024952015363;2021.706852506393;2190.441437433444;2467.962980555293;2479.7024357077084;2480.987595062013;2435.4641978764644;2453.7546245375497;2463.8275320727557;2472.7403622619727;2472.8021758259297;6923.757668481579;8047.839043219103;8827.646894124291;8847.557622118868;8877.023527411979;4381.539938306496;5415.48552887475;5437.755301011464;5460.945390546123;5477.452254774531;2969.9851500742575;3063.356695094033;3637.7635453695425;3684.0053185639727;3707.35121353762;973.6689525561272;987.8073775613758;1058.751193469534;1081.7181639756914;1099.6206308823444;10396.324238924446;10580.047795698347;11693.889080537336;11741.530338786439;11751.001164900994;4753.33453316536;4803.879903002453;4891.633127515451;4892.902141957212;4894.412670479565;9968.750781230527;10068.295219334723;10073.798524029478;10077.143442807443;10117.544710488046;5407.513323800798;5445.727713614304;5447.046766815792;5465.9180112298345;5513.145462453326;4400.405945197357;4818.566329030334;4902.240152776325;4932.161532539477;4980.726060066659;3817.484639573622;3895.2793733159456;3896.7661940283674;3917.980410097988;3943.684505239574;1287.2083668543964;1301.694101886056;1301.9739605208033;1308.13009348782;1309.9279539625222;1306.9477220911247;1346.9057165998481;1349.8785109340206;1357.864213578654;1367.6102310841363;8000.51996880189;8163.061247956561;8196.30331421824;8207;8233.34133269337;512.4260827872806;516.7287174233558;520.7682581251307;522.2427480153792;524.7140308531859;6204.81385558434;6206.410391012847;6245.125682404467;6285.717142728588;6288.465480434123;10433.061024507831;10861.565537378416;10878.564857405774;10915.945420272848;10949.726256843642;10521.631742888962;10699.197560183018;10723.30298530593;10782.137429005661;10834.187435942336;8258.380621453414;8289.668413263522;8377.916220837835;8383.748487545383;8407.95796021016;7797.376209903081;7801.804954875946;7815.10126335456;7820.296173344426;7876.369890408868;9503.952480237554;9574.521273936414;9628.18160456341;9654.469004204837;9696.806063878541;9720.805583888425;9911.752206194902;9979.351342162736;10090.142337901361;10165;6619.172603424572;7019.6841142147705;7313.890291645736;7476.5514069156025;7479.626018699152;8066.798330041796;8100.594970251582;8141.307988821017;8150.184981501802;8182.22268884455;7156.534825236343;7217.025701530436;7248.746293879689;7348.632568371453;7414.555126692416;7072.3988460979335;7201.279872012967;7218.27817218274;7230.9638451807405;7281.381082608038;7588.544687318778;7651.426143039405;7686.116096648733;7688.730894418669;7765.922340776746;6867.484938629723;6901.930980690129;6981.5112942093565;6982.057422247932;7003.824904377431;7007.509474336747;7047.506674532733;7087.645617719197;7101;7148.106486689164 01:20:06 INFO - PROCESS | 1683 | |4;prototype.html;284.4836621531919;325.580001797681;329.9076258647578;330.97186739127176;334.20459306849693;6661.433778128859;6709.597424154542;6710.664466776666;6738.528303018785;6782.016607591902;5567.6659400436;6605.636689982061;6607.438367738748;6658.633775142365;6696.397324240817;4585.220512512864;4792.9281060784115;4920.0159968006365;4930.6055515558755;4944.590791624388;4556;4580.839670611529;4846.127697014536;4903.950960490403;4943.728094954776;4837.588804951566;4872.610191184696;4890.73100979446;4895.388076490439;4900.921797204627;4870.707757534542;4876.97561512192;4900.460949295574;4908.9754551227015;4953.554180123806;4159.230542349645;4162.125953549758;4162.500499940026;4162.937555936664;4181.849991252399;6109.266887973472;6340.302566717657;6364.681765911686;6376.681165941731;6393.968030159819;4678.906421871544;4692;5826.912596311059;5847.356790753014;5869.7945571904775;7053.89419158713;7099.645017749143;7115.501914865961;7116.110486189226;7118.893216601755;4670.182718024332;4681.672282940195;4687.062587482517;4692.389989301369;4696.412948381452;6011.939880601181;7540.660670269851;7543.509671871366;7571.886421703679;7593.696252149907;4665.743384113838;4786.880327991758;4795.712257264506;4797.40032495938;4845.878853028632;4889.119958407521;4927.285543596158;4943.5797957174045;4951.702897826142;4959.107360675041;4411;5312.963972025418;5800.332961709373;5820.592558520862;5843.948089343959;5820.854478637983;7294.817629559304;7306.050213472215;7320.5607663539295;7332.156801967735;1698.9320427182774;1727.4472168906082;1731;1734.5663584103975;1735.1671197825115;1089.1178145702006;1120.8542889424323;1128.2722643894642;1135.9204855660025;1146.9655910322538;6646.8005959821285;6660.134182556237;6682.933170668328;6685.465162787063;6706.094677218611;7428.517146385576;7429.294217049372;7452.441066920002;7462.179160292363;7489.550626962399;6441.3880681335195;6564.409203171642;6642.734290628321;6653.534252602271;6756.223034351015;3884.9611503885167;3942.9605703943166;3942.9605703943166;3943.2704949584418;3952.7628342299554;7840.059192896889;7841.294283514511;7844.254795794391;7854.8429031419055;7872.094709108412;7718.228177182237;7719.807004824812;7724.7682569523;7766.495177813424;7775.766726998199;7589.848203035908;7871.803204919808;7899.684012639545;7921.683132674743;7976.322012628875;6040.244969378828;6046.969765151146;6765.729370825112;7443;7560.281773231534;7443.590602516913;7444.994925684963;7448.031755871702;7461.4403919705155;7485.288897554724;7693.615319233904;7853.489523181203;7887.921120788718;7937.484063535851;7949.642266097924;3883;4639.907201855876;4643.442786865598;4691.929621055619;4715.363425937455;7520.623968801648;7526.811829704301;7552.773416797505;7577.810554736176;7589.544627322378;7228.457865660202;7265.963670181826;7276;7281.526700764433;7309.890351644836;6980.720771169096;7231.746888858865;7253.274672532704;7258.49190556656;7291.2293328534815;7028.929710702828;7081.114860642419;7089.113860767404;7094.1909812997355;7118.5017048806085;5356.651817631841;7131.286871313035;7249.601271929883;7272.709091636275;7290.781276561712;6005.87988240224;6804.741122892281;7058.364747172779;7105.3960413363375;7126.536775109601 01:20:06 INFO - PROCESS | 1683 | |5;yui.html;686.9862602747944;718.7735863203087;742.8885667149926;749.3293502315424;750.5084169868738;14914.776278355834;14926.253687315631;15045.6990860183;15096.77354839677;15227.162506062175;13362.66593335167;13443.1261967972;13457.46170153195;13492.392842322095;13541.322933853293;696.5994553131944;841.4993079117914;842.1326034184799;852.0116664668985;853.3855623950776;832.7460124661976;845.8519759042174;848.2323497234981;851.4635779458932;856.2165618459103;899.0964081098487;914.38279161566;922.1331947968921;925.0795458518784;934.0332755597957;892.486820078451;901.1934318784716;902.8645703144548;906.3021473465427;913.0686699566438;674.2919934069208;679.2935347238915;685.8936864785966;686.9690863911136;690.2752110284182;14843.332050057774;14922.776158357634;14954.177520236492;14965.551033469013;15009.774853377208;12596.181248218836;12649.557265495756;12699.555515557004;12854.614361569167;12861.099723019392;9897.604095836157;10132.24008199388;10173.694789156338;10233.181345492343;10543.578256869716;3550.609432962372;3551;3554.3424466473784;3587.4260118380935;3644.9817750911343;61922;80929;81836.59081704554;82578;82909.75635365474;9359.391639543408;9365.391249568756;9485.4782986935;9578.56896439662;9652.27607929408;17875.838070525373;19167.233310667416;20304;20362.28731994373;20388.490287742927;6079;7482.5884576347735;7483.064616922885;7575.204603516661;7582.431317651198;4104.384342348671;4182.309918863353;4199.160167966419;4209.052963083343;4209.473815773028;3545.982270088685;3548.414511605608;3578.910527236788;3587.802670853076;3587.8564857405413;649.3506493506494;649.7206201333472;659.0608383054129;661.7286912366003;663.2604645819877;579.4321564866455;591.8695291992274;610.1732152932801;611.2176414189844;650.606383138204;7706.807329816799;8192.34461243099;8240.093589705128;8384.610386039949;8430.915690843136;496.18873142412417;527.2565682387815;553.8559974406684;579.982600521985;595.6336852835475;3860.8069596520063;3863.555691095504;3888.5916978716828;3909.9834043148417;3963.8612648557164;85444.57277713572;86908;86974.13025869787;87127;88442.67335989965;53877.73061134669;65822;75131.24868751352;75463.62268188734;76058.47883042308;63606;66183.66908165428;66854.66290674257;68509;68921.65539172271;6427.807165785034;8266.8370556388;8323.6670533178;8357.331413486785;8565.146450175143;35551.267116952346;41060.79469602633;47566.28650570175;49332.75333623309;50751.746241268556;66200.66899665663;66673.33316667122;67922.66038669775;68018.63962720618;71004.64497677685;10778.784424311627;10801.513931873242;10905.945470272598;11137.610183643534;11731.061515078603;11980.700482488008;12200;12364.1963272387;12389.75220495603;12437.440315185657;11339.149563782585;11356.676675683184;11459.713507162387;11494.252873563191;11919.284842909454;11086.279391839505;11487.712807179887;11499.770004599693;11786.76426471483;11923.642290731292;11111.999200719418;11231.15766317513;11235.382053986783;11239.269447485887;11617.941910290394;9018.729438116867;9383.624655013722;9389.765255868659;9535.38020028696;9608.95195524018;9490.098440648128;9757.756056098655;9765.121139097515;9776.608935642778;9800.313978021755 01:20:06 INFO - PROCESS | 1683 | __end_tp_report 01:20:06 INFO - PROCESS | 1683 | __start_cc_report 01:20:06 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,350 01:20:06 INFO - PROCESS | 1683 | __end_cc_report 01:20:06 INFO - PROCESS | 1683 | __startTimestamp1456478406946__endTimestamp 01:20:06 INFO - PROCESS | 1683 | 01:20:06 INFO - PROCESS | 1683 | ------- Summary: start ------- 01:20:06 INFO - PROCESS | 1683 | Number of tests: 6 01:20:06 INFO - PROCESS | 1683 | 01:20:06 INFO - PROCESS | 1683 | [#0] dojo.html Cycles:165 Average:5624.92 Median:5790.57 stddev:663.69 (11.5%) stddev-sans-first:626.65 01:20:06 INFO - PROCESS | 1683 | Values: 2764.7 3419.8 3456.8 3528.6 3551.6 4604.9 5610.2 5665.0 5713.1 5727.8 5624.9 5638.3 5741.2 5763.4 5780.3 4904.1 5118.5 5131.2 5197.3 5257.7 5167.5 5185.1 5201.6 5223.8 5229.6 5005.9 5037.4 5110.3 5166.0 5220.5 5137.4 5142.0 5143.3 5145.6 5147.5 5101.6 5123.8 5148.7 5149.7 5175.6 4596.5 4926.0 5496.9 5614.5 5662.4 6145.3 6152.7 6172.1 6174.1 6198.3 6114.3 6212.5 6222.3 6237.8 6249.8 5676.5 5725.9 5741.3 5785.0 5786.3 6237.9 6239.9 6251.2 6269.0 6273.0 5486.7 5956.1 6102.4 6110.4 6139.1 5661.3 6033.9 6096.3 6108.1 6118.7 6109.3 6109.7 6120.2 6171.1 6180.2 6057.4 6200.9 6221.9 6228.6 6234.0 4735.4 4840.9 4842.6 4868.4 4898.6 4330.7 4351.9 4362.5 4382.6 4395.9 5593.6 5716.7 5754.0 5777.7 5806.7 6169.4 6207.0 6224.4 6239.3 6256.0 4876.3 5759.0 5778.5 5797.1 5806.6 5191.0 5266.1 5318.6 5328.4 5346.1 4913.0 4945.4 5284.4 6246.9 6386.5 6218.8 6242.7 6262.5 6268.7 6269.7 6116.2 6176.4 6206.2 6245.1 6299.5 6122.6 6143.7 6162.9 6164.5 6169.6 6114.8 6213.7 6218.8 6224.8 6226.9 5093.8 5521.9 5879.2 5915.3 6010.2 4664.8 5973.3 5993.7 6078.2 6095.0 5790.6 5839.4 5886.2 5897.0 5909.2 5732.7 6006.2 6077.9 6087.6 6132.1 4878.3 5928.5 5931.3 5971.6 5980.3 01:20:06 INFO - PROCESS | 1683 | 01:20:06 INFO - PROCESS | 1683 | [#1] ext.html Cycles:180 Average:62618.36 Median:38145.05 stddev:131441.43 (344.6%) stddev-sans-first:131727.21 01:20:06 INFO - PROCESS | 1683 | Values: 423.0 451.9 459.8 531.3 591.1 37441.6 37886.0 38009.8 38123.2 38166.9 38872.6 39411.0 39543.6 39602.0 39616.8 9413.0 9672.7 9680.8 9709.0 9712.7 9507.3 9642.0 9649.9 9651.2 9656.3 8175.4 8898.0 9635.4 9664.0 9693.4 9524.8 9611.4 9619.8 9634.4 9635.8 9466.5 9591.8 9595.2 9620.4 9631.2 36819.6 37385.8 37471.1 37520.4 37666.8 3204.2 3322.0 3402.9 3412.7 3770.5 21961.8 24118.4 27826.8 28345.4 28558.4 2774.2 2782.1 2848.7 2854.2 2905.6 459511.0 461309.0 463240.0 464447.0 465945.0 44113.0 63726.7 63745.7 64132.0 64197.4 35883.8 37959.3 40643.2 43132.1 43439.6 15137.5 15378.9 15401.4 15443.5 15491.8 12162.1 12362.8 12398.4 12509.0 12509.5 13965.9 14062.9 14393.7 14415.5 14419.4 5288.8 5973.9 6129.5 6148.9 6164.0 924.6 928.9 941.9 1040.3 1063.1 23747.5 27880.4 28666.7 28871.3 29644.9 1050.1 1071.8 1074.3 1126.7 1237.7 14682.8 14812.3 14890.0 15042.5 15404.2 526021.4 529256.0 532881.0 533392.0 534293.0 53880.0 55352.7 55668.4 55972.0 56091.7 1179.4 1336.2 1392.2 1397.0 1404.6 28591.9 28882.6 29284.9 29355.0 29371.7 48889.5 52736.5 53844.0 53944.7 53952.2 478793.0 480278.0 487618.0 487889.0 489192.0 41697.8 42367.4 42743.0 42946.6 42949.6 41224.6 41390.2 41421.0 41656.2 42101.4 34415.0 36840.4 37550.2 38323.6 38402.8 33959.8 34500.5 34504.7 34865.8 35524.3 34926.5 36470.1 37125.0 37798.4 37989.1 27451.9 29650.0 33270.8 33339.0 33603.0 23842.1 23872.9 24526.8 24846.0 25408.6 01:20:06 INFO - PROCESS | 1683 | 01:20:06 INFO - PROCESS | 1683 | [#2] jquery.html Cycles:180 Average:30885.96 Median:11625.95 stddev:83836.75 (721.1%) stddev-sans-first:84040.43 01:20:06 INFO - PROCESS | 1683 | Values: 274.6 351.1 358.9 360.5 367.7 19423.9 19514.7 20777.9 21074.9 21124.6 17028.8 20118.0 20601.7 20641.4 20691.2 5806.5 6090.2 6130.7 6154.1 6159.5 4234.4 5969.0 6356.2 6659.4 6680.5 6526.6 6598.4 6608.1 6611.7 6618.0 6438.8 6587.2 6590.2 6605.1 6636.9 4791.3 5334.2 5667.4 5696.3 5707.2 13091.2 13272.8 13310.7 13329.5 13330.9 2110.7 2127.3 2183.9 2200.9 2731.7 9641.8 9884.4 10178.5 14035.0 14461.6 1712.7 1728.8 1744.8 1787.3 1824.0 101092.0 104572.0 105353.5 105530.0 106935.9 9919.4 10760.8 10803.4 11059.7 11290.1 13611.7 13681.2 13722.2 13764.1 13781.9 6954.5 8552.8 8596.9 8634.7 8724.2 7191.4 8736.0 8740.5 8767.6 8883.2 3737.3 4321.4 4483.0 4524.6 4534.6 1435.0 1536.0 1697.2 1812.9 1899.4 839.9 884.5 889.3 978.9 1060.0 18866.8 20106.6 20145.7 20294.0 20361.0 966.0 974.5 974.6 1005.1 1019.3 10380.8 10565.9 10610.8 10653.9 10654.0 443873.0 496165.0 506708.0 522943.0 531617.0 99943.0 108290.0 108558.4 114041.9 117513.0 816.3 976.3 1004.1 1016.5 1019.2 13571.2 14440.6 17748.5 17759.3 17825.2 51382.5 52331.0 52449.7 53756.0 55729.0 71951.0 73896.0 74780.0 74784.0 77238.0 7790.1 7844.8 7894.0 7909.8 7913.1 10518.9 12158.6 12929.8 13294.4 13316.3 11183.2 11183.7 11193.9 11250.7 11661.0 8988.9 11189.2 11204.9 11423.3 11742.1 9020.8 10906.6 11408.0 11501.1 11818.1 7532.4 8017.3 8156.7 8157.3 8364.5 10863.8 11000.9 11150.4 11159.2 11169.4 01:20:06 INFO - PROCESS | 1683 | 01:20:06 INFO - PROCESS | 1683 | [#3] mootools.html Cycles:180 Average:5986.31 Median:5411.50 stddev:3178.12 (58.7%) stddev-sans-first:3169.44 01:20:06 INFO - PROCESS | 1683 | Values: 1537.9 1564.9 1805.9 1922.1 1924.9 7812.0 8420.9 8588.9 8792.3 8830.5 8529.5 8576.9 8675.8 8701.3 8713.5 2297.5 2299.4 2300.2 2321.2 2324.8 2391.6 2412.5 2469.4 2475.4 2475.9 2434.3 2446.8 2451.1 2488.2 2492.2 2021.7 2190.4 2468.0 2479.7 2481.0 2435.5 2453.8 2463.8 2472.7 2472.8 6923.8 8047.8 8827.6 8847.6 8877.0 4381.5 5415.5 5437.8 5460.9 5477.5 2970.0 3063.4 3637.8 3684.0 3707.4 973.7 987.8 1058.8 1081.7 1099.6 10396.3 10580.0 11693.9 11741.5 11751.0 4753.3 4803.9 4891.6 4892.9 4894.4 9968.8 10068.3 10073.8 10077.1 10117.5 5407.5 5445.7 5447.0 5465.9 5513.1 4400.4 4818.6 4902.2 4932.2 4980.7 3817.5 3895.3 3896.8 3918.0 3943.7 1287.2 1301.7 1302.0 1308.1 1309.9 1306.9 1346.9 1349.9 1357.9 1367.6 8000.5 8163.1 8196.3 8207.0 8233.3 512.4 516.7 520.8 522.2 524.7 6204.8 6206.4 6245.1 6285.7 6288.5 10433.1 10861.6 10878.6 10915.9 10949.7 10521.6 10699.2 10723.3 10782.1 10834.2 8258.4 8289.7 8377.9 8383.7 8408.0 7797.4 7801.8 7815.1 7820.3 7876.4 9504.0 9574.5 9628.2 9654.5 9696.8 9720.8 9911.8 9979.4 10090.1 10165.0 6619.2 7019.7 7313.9 7476.6 7479.6 8066.8 8100.6 8141.3 8150.2 8182.2 7156.5 7217.0 7248.7 7348.6 7414.6 7072.4 7201.3 7218.3 7231.0 7281.4 7588.5 7651.4 7686.1 7688.7 7765.9 6867.5 6901.9 6981.5 6982.1 7003.8 7007.5 7047.5 7087.6 7101.0 7148.1 01:20:06 INFO - PROCESS | 1683 | 01:20:06 INFO - PROCESS | 1683 | [#4] prototype.html Cycles:180 Average:5841.28 Median:6625.09 stddev:1892.87 (28.6%) stddev-sans-first:1851.66 01:20:06 INFO - PROCESS | 1683 | Values: 284.5 325.6 329.9 331.0 334.2 6661.4 6709.6 6710.7 6738.5 6782.0 5567.7 6605.6 6607.4 6658.6 6696.4 4585.2 4792.9 4920.0 4930.6 4944.6 4556.0 4580.8 4846.1 4904.0 4943.7 4837.6 4872.6 4890.7 4895.4 4900.9 4870.7 4877.0 4900.5 4909.0 4953.6 4159.2 4162.1 4162.5 4162.9 4181.8 6109.3 6340.3 6364.7 6376.7 6394.0 4678.9 4692.0 5826.9 5847.4 5869.8 7053.9 7099.6 7115.5 7116.1 7118.9 4670.2 4681.7 4687.1 4692.4 4696.4 6011.9 7540.7 7543.5 7571.9 7593.7 4665.7 4786.9 4795.7 4797.4 4845.9 4889.1 4927.3 4943.6 4951.7 4959.1 4411.0 5313.0 5800.3 5820.6 5843.9 5820.9 7294.8 7306.1 7320.6 7332.2 1698.9 1727.4 1731.0 1734.6 1735.2 1089.1 1120.9 1128.3 1135.9 1147.0 6646.8 6660.1 6682.9 6685.5 6706.1 7428.5 7429.3 7452.4 7462.2 7489.6 6441.4 6564.4 6642.7 6653.5 6756.2 3885.0 3943.0 3943.0 3943.3 3952.8 7840.1 7841.3 7844.3 7854.8 7872.1 7718.2 7719.8 7724.8 7766.5 7775.8 7589.8 7871.8 7899.7 7921.7 7976.3 6040.2 6047.0 6765.7 7443.0 7560.3 7443.6 7445.0 7448.0 7461.4 7485.3 7693.6 7853.5 7887.9 7937.5 7949.6 3883.0 4639.9 4643.4 4691.9 4715.4 7520.6 7526.8 7552.8 7577.8 7589.5 7228.5 7266.0 7276.0 7281.5 7309.9 6980.7 7231.7 7253.3 7258.5 7291.2 7028.9 7081.1 7089.1 7094.2 7118.5 5356.7 7131.3 7249.6 7272.7 7290.8 6005.9 6804.7 7058.4 7105.4 7126.5 01:20:06 INFO - PROCESS | 1683 | 01:20:06 INFO - PROCESS | 1683 | [#5] yui.html Cycles:180 Average:17543.39 Median:62764.00 stddev:24287.36 (38.7%) stddev-sans-first:24322.52 01:20:06 INFO - PROCESS | 1683 | Values: 687.0 718.8 742.9 749.3 750.5 14914.8 14926.3 15045.7 15096.8 15227.2 13362.7 13443.1 13457.5 13492.4 13541.3 696.6 841.5 842.1 852.0 853.4 832.7 845.9 848.2 851.5 856.2 899.1 914.4 922.1 925.1 934.0 892.5 901.2 902.9 906.3 913.1 674.3 679.3 685.9 687.0 690.3 14843.3 14922.8 14954.2 14965.6 15009.8 12596.2 12649.6 12699.6 12854.6 12861.1 9897.6 10132.2 10173.7 10233.2 10543.6 3550.6 3551.0 3554.3 3587.4 3645.0 61922.0 80929.0 81836.6 82578.0 82909.8 9359.4 9365.4 9485.5 9578.6 9652.3 17875.8 19167.2 20304.0 20362.3 20388.5 6079.0 7482.6 7483.1 7575.2 7582.4 4104.4 4182.3 4199.2 4209.1 4209.5 3546.0 3548.4 3578.9 3587.8 3587.9 649.4 649.7 659.1 661.7 663.3 579.4 591.9 610.2 611.2 650.6 7706.8 8192.3 8240.1 8384.6 8430.9 496.2 527.3 553.9 580.0 595.6 3860.8 3863.6 3888.6 3910.0 3963.9 85444.6 86908.0 86974.1 87127.0 88442.7 53877.7 65822.0 75131.2 75463.6 76058.5 63606.0 66183.7 66854.7 68509.0 68921.7 6427.8 8266.8 8323.7 8357.3 8565.1 35551.3 41060.8 47566.3 49332.8 50751.7 66200.7 66673.3 67922.7 68018.6 71004.6 10778.8 10801.5 10905.9 11137.6 11731.1 11980.7 12200.0 12364.2 12389.8 12437.4 11339.1 11356.7 11459.7 11494.3 11919.3 11086.3 11487.7 11499.8 11786.8 11923.6 11112.0 11231.2 11235.4 11239.3 11617.9 9018.7 9383.6 9389.8 9535.4 9609.0 9490.1 9757.8 9765.1 9776.6 9800.3 01:20:06 INFO - PROCESS | 1683 | -------- Summary: end -------- 01:20:06 INFO - PROCESS | 1683 | 01:20:07 INFO - TEST-INFO | 1683: exit 0 01:20:07 INFO - TEST-OK | dromaeo_css | took 1110475ms 01:20:07 INFO - TEST-START | kraken 01:20:07 INFO - operating with platform_type : mac_ 01:20:07 INFO - Initialising browser for kraken test... 01:20:07 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmpKU5WN5/profile http://localhost:49282/getInfo.html) 01:20:09 INFO - PROCESS | 1690 | __metrics Screen width/height:1600/1200 01:20:09 INFO - PROCESS | 1690 | colorDepth:24 01:20:09 INFO - PROCESS | 1690 | Browser inner width/height: 1024/689 01:20:09 INFO - PROCESS | 1690 | __metrics 01:20:10 ERROR - PROCESS | 1690 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 01:20:10 INFO - TEST-INFO | 1690: exit 0 01:20:10 INFO - Browser initialized. 01:20:10 INFO - Running cycle 1/1 for kraken test... 01:20:10 INFO - TEST-INFO | started process 1693 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmpKU5WN5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:20:22 INFO - PROCESS | 1693 | RSS: Main: 255467520 01:20:22 INFO - PROCESS | 1693 | 01:20:25 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-beat-detection) 01:20:25 INFO - PROCESS | 1693 | RSS: Main: 268918784 01:20:25 INFO - PROCESS | 1693 | 01:20:28 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-dft) 01:20:29 INFO - PROCESS | 1693 | RSS: Main: 276873216 01:20:29 INFO - PROCESS | 1693 | 01:20:32 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-fft) 01:20:33 INFO - PROCESS | 1693 | RSS: Main: 281542656 01:20:33 INFO - PROCESS | 1693 | 01:20:35 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-oscillator) 01:20:35 INFO - PROCESS | 1693 | RSS: Main: 282058752 01:20:35 INFO - PROCESS | 1693 | 01:20:37 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:20:38 INFO - PROCESS | 1693 | RSS: Main: 284028928 01:20:38 INFO - PROCESS | 1693 | 01:20:41 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-darkroom) 01:20:42 INFO - PROCESS | 1693 | RSS: Main: 283697152 01:20:42 INFO - PROCESS | 1693 | 01:20:44 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-desaturate) 01:20:45 INFO - PROCESS | 1693 | RSS: Main: 283377664 01:20:45 INFO - PROCESS | 1693 | 01:20:48 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49282/tests/kraken/driver.html?testName=json-parse-financial) 01:20:48 INFO - PROCESS | 1693 | RSS: Main: 284024832 01:20:48 INFO - PROCESS | 1693 | 01:20:50 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49282/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:20:51 INFO - PROCESS | 1693 | RSS: Main: 282959872 01:20:51 INFO - PROCESS | 1693 | 01:20:53 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:20:53 INFO - PROCESS | 1693 | RSS: Main: 282886144 01:20:53 INFO - PROCESS | 1693 | 01:20:55 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:20:56 INFO - PROCESS | 1693 | RSS: Main: 282963968 01:20:56 INFO - PROCESS | 1693 | 01:20:58 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:20:59 INFO - PROCESS | 1693 | RSS: Main: 282374144 01:20:59 INFO - PROCESS | 1693 | 01:21:02 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:21:02 INFO - PROCESS | 1693 | RSS: Main: 282468352 01:21:02 INFO - PROCESS | 1693 | 01:21:04 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49282/tests/kraken/driver.html?testName=ai-astar) 01:21:04 INFO - PROCESS | 1693 | RSS: Main: 284884992 01:21:04 INFO - PROCESS | 1693 | 01:21:04 INFO - PROCESS | 1693 | __start_tp_report 01:21:04 INFO - PROCESS | 1693 | _x_x_mozilla_page_load 01:21:04 INFO - PROCESS | 1693 | _x_x_mozilla_page_load_details 01:21:04 INFO - PROCESS | 1693 | |i|pagename|runs| 01:21:04 INFO - PROCESS | 1693 | |0;ai-astar;114;111;120;114;115;123;114;114;116;113 01:21:04 INFO - PROCESS | 1693 | |1;audio-beat-detection;151;108;163;170;147;172;173;124;194;122 01:21:04 INFO - PROCESS | 1693 | |2;audio-dft;196;199;199;202;204;257;214;281;220;199 01:21:04 INFO - PROCESS | 1693 | |3;audio-fft;70;76;73;113;58;57;57;59;132;72 01:21:04 INFO - PROCESS | 1693 | |4;audio-oscillator;82;80;105;109;119;121;145;61;111;158 01:21:04 INFO - PROCESS | 1693 | |5;imaging-gaussian-blur;85;92;85;92;87;90;85;114;130;88 01:21:04 INFO - PROCESS | 1693 | |6;imaging-darkroom;93;95;96;94;95;94;96;95;95;94 01:21:04 INFO - PROCESS | 1693 | |7;imaging-desaturate;106;148;149;92;92;94;92;92;91;92 01:21:04 INFO - PROCESS | 1693 | |8;json-parse-financial;60;59;60;56;57;56;57;68;58;58 01:21:04 INFO - PROCESS | 1693 | |9;json-stringify-tinderbox;65;74;70;91;117;107;88;68;69;71 01:21:04 INFO - PROCESS | 1693 | |10;stanford-crypto-aes;87;85;86;87;88;85;85;89;91;88 01:21:04 INFO - PROCESS | 1693 | |11;stanford-crypto-ccm;130;129;128;123;130;143;138;133;140;142 01:21:04 INFO - PROCESS | 1693 | |12;stanford-crypto-pbkdf2;147;142;142;143;149;142;143;139;137;151 01:21:04 INFO - PROCESS | 1693 | |13;stanford-crypto-sha256-iterative;68;68;68;68;67;68;69;88;63;68 01:21:04 INFO - PROCESS | 1693 | __end_tp_report 01:21:04 INFO - PROCESS | 1693 | __start_cc_report 01:21:04 INFO - PROCESS | 1693 | _x_x_mozilla_cycle_collect,892 01:21:04 INFO - PROCESS | 1693 | __end_cc_report 01:21:04 INFO - PROCESS | 1693 | __startTimestamp1456478464671__endTimestamp 01:21:04 INFO - PROCESS | 1693 | 01:21:04 INFO - PROCESS | 1693 | ------- Summary: start ------- 01:21:04 INFO - PROCESS | 1693 | Number of tests: 14 01:21:04 INFO - PROCESS | 1693 | 01:21:04 INFO - PROCESS | 1693 | [#0] ai-astar Cycles:10 Average:115.40 Median:114.50 stddev:3.53 (3.1%) stddev-sans-first:3.71 01:21:04 INFO - PROCESS | 1693 | Values: 114.0 111.0 120.0 114.0 115.0 123.0 114.0 114.0 116.0 113.0 01:21:04 INFO - PROCESS | 1693 | 01:21:04 INFO - PROCESS | 1693 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:166.50 stddev:27.27 (16.4%) stddev-sans-first:28.92 01:21:04 INFO - PROCESS | 1693 | Values: 151.0 108.0 163.0 170.0 147.0 172.0 173.0 124.0 194.0 122.0 01:21:04 INFO - PROCESS | 1693 | 01:21:04 INFO - PROCESS | 1693 | [#2] audio-dft Cycles:10 Average:217.10 Median:209.00 stddev:28.91 (13.8%) stddev-sans-first:29.64 01:21:04 INFO - PROCESS | 1693 | Values: 196.0 199.0 199.0 202.0 204.0 257.0 214.0 281.0 220.0 199.0 01:21:04 INFO - PROCESS | 1693 | 01:21:04 INFO - PROCESS | 1693 | [#3] audio-fft Cycles:10 Average:76.70 Median:64.50 stddev:25.60 (39.7%) stddev-sans-first:27.03 01:21:04 INFO - PROCESS | 1693 | Values: 70.0 76.0 73.0 113.0 58.0 57.0 57.0 59.0 132.0 72.0 01:21:04 INFO - PROCESS | 1693 | 01:21:04 INFO - PROCESS | 1693 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:151.50 stddev:29.50 (19.5%) stddev-sans-first:29.62 01:21:04 INFO - PROCESS | 1693 | Values: 82.0 80.0 105.0 109.0 119.0 121.0 145.0 61.0 111.0 158.0 01:21:04 INFO - PROCESS | 1693 | 01:21:04 INFO - PROCESS | 1693 | [#5] imaging-gaussian-blur Cycles:10 Average:94.80 Median:87.50 stddev:15.06 (17.2%) stddev-sans-first:15.55 01:21:04 INFO - PROCESS | 1693 | Values: 85.0 92.0 85.0 92.0 87.0 90.0 85.0 114.0 130.0 88.0 01:21:04 INFO - PROCESS | 1693 | 01:21:04 INFO - PROCESS | 1693 | [#6] imaging-darkroom Cycles:10 Average:94.70 Median:95.00 stddev:0.95 (1.0%) stddev-sans-first:0.78 01:21:04 INFO - PROCESS | 1693 | Values: 93.0 95.0 96.0 94.0 95.0 94.0 96.0 95.0 95.0 94.0 01:21:04 INFO - PROCESS | 1693 | 01:21:04 INFO - PROCESS | 1693 | [#7] imaging-desaturate Cycles:10 Average:104.80 Median:92.00 stddev:23.45 (25.5%) stddev-sans-first:24.86 01:21:04 INFO - PROCESS | 1693 | Values: 106.0 148.0 149.0 92.0 92.0 94.0 92.0 92.0 91.0 92.0 01:21:04 INFO - PROCESS | 1693 | 01:21:04 INFO - PROCESS | 1693 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:58.50 stddev:3.51 (6.0%) stddev-sans-first:3.70 01:21:04 INFO - PROCESS | 1693 | Values: 60.0 59.0 60.0 56.0 57.0 56.0 57.0 68.0 58.0 58.0 01:21:04 INFO - PROCESS | 1693 | 01:21:04 INFO - PROCESS | 1693 | [#9] json-stringify-tinderbox Cycles:10 Average:82.00 Median:70.50 stddev:18.10 (25.7%) stddev-sans-first:18.13 01:21:04 INFO - PROCESS | 1693 | Values: 65.0 74.0 70.0 91.0 117.0 107.0 88.0 68.0 69.0 71.0 01:21:04 INFO - PROCESS | 1693 | 01:21:04 INFO - PROCESS | 1693 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.50 stddev:1.97 (2.3%) stddev-sans-first:2.09 01:21:04 INFO - PROCESS | 1693 | Values: 87.0 85.0 86.0 87.0 88.0 85.0 85.0 89.0 91.0 88.0 01:21:04 INFO - PROCESS | 1693 | 01:21:04 INFO - PROCESS | 1693 | [#11] stanford-crypto-ccm Cycles:10 Average:133.60 Median:135.50 stddev:6.75 (5.0%) stddev-sans-first:7.04 01:21:04 INFO - PROCESS | 1693 | Values: 130.0 129.0 128.0 123.0 130.0 143.0 138.0 133.0 140.0 142.0 01:21:04 INFO - PROCESS | 1693 | 01:21:04 INFO - PROCESS | 1693 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.50 Median:143.00 stddev:4.33 (3.0%) stddev-sans-first:4.40 01:21:04 INFO - PROCESS | 1693 | Values: 147.0 142.0 142.0 143.0 149.0 142.0 143.0 139.0 137.0 151.0 01:21:04 INFO - PROCESS | 1693 | 01:21:04 INFO - PROCESS | 1693 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:68.00 stddev:6.70 (9.9%) stddev-sans-first:7.09 01:21:04 INFO - PROCESS | 1693 | Values: 68.0 68.0 68.0 68.0 67.0 68.0 69.0 88.0 63.0 68.0 01:21:04 INFO - PROCESS | 1693 | -------- Summary: end -------- 01:21:04 INFO - PROCESS | 1693 | 01:21:05 INFO - TEST-INFO | 1693: exit 0 01:21:05 INFO - TEST-OK | kraken | took 57998ms 01:21:05 INFO - SUITE-END | took 1168s 01:21:05 INFO - Completed test suite (00:19:28) 01:21:05 INFO - Working with test: dromaeo_css 01:21:05 INFO - Generating results file: dromaeo_css 01:21:05 INFO - Working with test: kraken 01:21:05 INFO - Generating results file: kraken 01:21:05 INFO - javascript benchmark 01:21:05 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:21:06 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 01:21:06 INFO - process_Request line: dromaeo_css 7399.34 graph.html#tests=[[72,64,61]] 01:21:06 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:21:06 INFO - process_Request line: kraken 1539.60 graph.html#tests=[[232,64,61]] 01:21:06 INFO - RETURN: dromaeo_css: 7399.34 01:21:06 INFO - RETURN: kraken: 1539.60 01:21:06 INFO - javascript benchmark 01:21:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2764.654418197725, 3419.81191034493, 3456.8444420001097, 3528.576570811503, 3551.6093229744706, 4604.884877878055, 5610.214569960209, 5665.008623490893, 5713.085906255, 5727.799527016556, 5624.887502249952, 5638.295213098363, 5741.167530708045, 5763.423657634245, 5780.306363236417, 4904.0927428425675, 5118.462561431052, 5131.230315452674, 5197.298364720752, 5257.658252213594, 5167.48325167484, 5185.092608793465, 5201.609879259052, 5223.843284701465, 5229.633925625208, 5005.949940500621, 5037.370328708911, 5110.2590124431745, 5165.974170129125, 5220.504052115043, 5137.357830271216, 5141.974290128525, 5143.3313669223135, 5145.614078944094, 5147.510986456281, 5101.591872650179, 5123.769430375642, 5148.665336753099, 5149.716765577892, 5175.611829112794, 4596.540345965377, 4926.0394223126505, 5496.917546236809, 5614.494695477427, 5662.37713851476, 6145.262568491765, 6152.723127459275, 6172.105044768484, 6174.135621013062, 6198.34917333678, 6114.297368146132, 6212.502999760009, 6222.284437289724, 6237.7816776413065, 6249.781257656005, 5676.489115979541, 5725.885482290331, 5741.282339707536, 5784.95870743266, 5786.3056433228285, 6237.937620623827, 6239.875202496016, 6251.249850018027, 6269.028300613412, 6273.0, 5486.655769336458, 5956.106584012433, 6102.389761023951, 6110.358412366638, 6139.140520327158, 5661.3206415229615, 6033.909491357633, 6096.329403765582, 6108.144859719643, 6118.680093383066, 6109.34393638171, 6109.6639684817765, 6120.204373431515, 6171.074338849119, 6180.227471566054, 6057.42454466825, 6200.906986395207, 6221.9377806222265, 6228.564000520011, 6234.0, 4735.360726301974, 4840.903181936412, 4842.6368022397755, 4868.440129385095, 4898.559129678346, 4330.718503297276, 4351.912961740747, 4362.498312694081, 4382.583654552813, 4395.901024743814, 5593.636413633101, 5716.657000579895, 5754.0, 5777.682227477445, 5806.65160090396, 6169.444749972524, 6206.975848984867, 6224.37756224374, 6239.313675495692, 6256.0303153011355, 4876.292937524039, 5759.020966435716, 5778.508826749773, 5797.130430435384, 5806.622569532967, 5190.97404512975, 5266.104762190437, 5318.627696061239, 5328.413874473805, 5346.117890548094, 4913.0, 4945.381827271663, 5284.39229488606, 6246.906296405557, 6386.489080873612, 6218.81343559694, 6242.65665388408, 6262.46769024638, 6268.749250029948, 6269.749210031548, 6116.214037636738, 6176.413240742122, 6206.162168107428, 6245.125682404558, 6299.464545513682, 6122.632642041492, 6143.72353244114, 6162.938370616416, 6164.47601953839, 6169.629822210682, 6114.847128821815, 6213.720382582705, 6218.844528886814, 6224.844378890564, 6226.906596401148, 5093.796248150181, 5521.861953451196, 5879.235699359056, 5915.349311575809, 6010.188624535632, 4664.79008444614, 5973.283206015306, 5993.670348130895, 6078.179445774764, 6094.969525152346, 5790.565707571865, 5839.445252700986, 5886.23478947734, 5896.970515147397, 5909.172715819875, 5732.742026608896, 6006.219191505251, 6077.878442431215, 6087.634741915322, 6132.141500190066, 4878.317035615088, 5928.466438020599, 5931.347551769388, 5971.61184523022, 5980.252468441445], "unit": "score", "name": "dojo.html", "value": 5584.8350221914}, {"lowerIsBetter": false, "replicates": [422.97462152270884, 451.93672885795985, 459.76322194070036, 531.2721571447119, 591.1280860730426, 37441.62558374416, 37885.999999999935, 38009.809950950206, 38123.23753524928, 38166.85499435014, 38872.611273887254, 39411.0, 39543.60456395435, 39602.0, 39616.80191599038, 9412.964573896867, 9672.661456849011, 9680.757981050494, 9708.951455242714, 9712.70861874145, 9507.334486585942, 9642.035796420338, 9649.90350096497, 9651.179649729746, 9656.324057315991, 8175.427720059598, 8898.021217666084, 9635.421874687507, 9664.0, 9693.3699309545, 9524.761880952998, 9611.423314601112, 9619.759506012335, 9634.373765705277, 9635.759106022371, 9466.479343636098, 9591.808163836755, 9595.23238140947, 9620.37467564606, 9631.181349585293, 36819.631803681885, 37385.813070934746, 37471.06322341936, 37520.43719344212, 37666.81166594177, 3204.1669166016773, 3322.0200040987966, 3402.931941361159, 3412.744044196695, 3770.4721339012285, 21961.78038219613, 24118.39704007414, 27826.84809421499, 28345.433091338058, 28558.428831423254, 2774.209350335145, 2782.1236310562313, 2848.6724026736983, 2854.158023383107, 2905.5786910898014, 459511.0, 461309.0, 463239.9999999966, 464447.0, 465945.0, 44113.0, 63726.68136659287, 63745.68127159335, 64132.0, 64197.35802642007, 35883.82058089693, 37959.342846000516, 40643.1871362577, 43132.137357253305, 43439.56560434355, 15137.470188543568, 15378.923105384401, 15401.383944642314, 15443.536693899201, 15491.845081549265, 12162.148649594443, 12362.75274494505, 12398.388209532703, 12509.0, 12509.499620015098, 13965.882729381625, 14062.859371406155, 14393.712125757425, 14415.495457658932, 14419.42322307096, 5288.762005709676, 5973.850653733604, 6129.467633091727, 6148.938510614837, 6164.044573091178, 924.5839372282366, 928.8560273157672, 941.8869735631768, 1040.33546325878, 1063.0857462582173, 23747.525049498912, 27880.442391152064, 28666.71333286682, 28871.278218044718, 29644.851775740983, 1050.1336397472116, 1071.78028504158, 1074.333912973961, 1126.6845283320683, 1237.672016915518, 14682.779758303634, 14812.333444994785, 14890.032147910351, 15042.548723538312, 15404.229788510529, 526021.3698931481, 529256.0, 532881.0, 533392.0, 534293.0, 53880.0, 55352.72323638356, 55668.44331556633, 55972.0, 56091.71954140285, 1179.4161889864572, 1336.1648969394128, 1392.2342711508832, 1397.0360451288577, 1404.6277736399861, 28591.85704071466, 28882.566761499016, 29284.853575731984, 29355.0, 29371.7062829369, 48889.51110488992, 52736.47263527469, 53844.0, 53944.73027634837, 53952.19071713849, 478793.0, 480278.0, 487618.0, 487889.0, 489192.0, 41697.79151104225, 42367.36448953207, 42743.0, 42946.57053429426, 42949.570504294556, 41224.587754122076, 41390.1721965565, 41421.0, 41656.16687666169, 42101.36847947344, 34415.0, 36840.44739328966, 37550.24899502049, 38323.616763832004, 38402.807985959895, 33959.83020084884, 34500.48249276212, 34504.65495345015, 34865.82567087148, 35524.28951420906, 34926.47610285797, 36470.08824779402, 37125.0, 37798.43302350522, 37989.05027374338, 27451.862740686167, 29650.0, 33270.83364583162, 33339.0, 33603.0, 23842.13209640849, 23872.88063559671, 24526.754732452446, 24846.0, 25408.618870716586], "unit": "score", "name": "ext.html", "value": 18871.87954563599}, {"lowerIsBetter": false, "replicates": [274.5607028753993, 351.1221945137157, 358.92642008388276, 360.4521127885614, 367.73339328986503, 19423.902880485595, 19514.7072793908, 20777.85721785303, 21074.89462552685, 21124.57750844982, 17028.829711702878, 20117.994100295, 20601.690974635392, 20641.38075857723, 20691.172353105896, 5806.506446952004, 6090.208272924514, 6130.693465326738, 6154.138420621094, 6159.538034647397, 4234.449521562193, 5969.0, 6356.2054743157105, 6659.433948114416, 6680.498962577802, 6526.641034743087, 6598.406143447089, 6608.107905432753, 6611.735530578771, 6618.0, 6438.806835794933, 6587.2095348558005, 6590.209174899042, 6605.108310378109, 6636.867262654744, 4791.305260737174, 5334.22653715213, 5667.404922483162, 5696.316442026942, 5707.200991861143, 13091.214527128403, 13272.800907986388, 13310.735480129371, 13329.466821327136, 13330.933345333211, 2110.7361579802523, 2127.3298910843037, 2183.9017244224046, 2200.9119635214574, 2731.685856126551, 9641.807163856683, 9884.406935583887, 10178.541965611492, 14035.01754877159, 14461.638459038502, 1712.6574685062913, 1728.7579738836573, 1744.7819022622173, 1787.2850859656112, 1823.9968017590404, 101092.0, 104572.0, 105353.47323263412, 105530.0, 106935.93064069415, 9919.40483570988, 10760.838587421194, 10803.351798892092, 11059.668209953714, 11290.096792256763, 13611.659708507168, 13681.179129252278, 13722.245276509688, 13764.105333153313, 13781.86218137826, 6954.47841411886, 8552.786180345416, 8596.8710469343, 8634.697785577475, 8724.214820666171, 7191.424686025105, 8736.039035706068, 8740.519271440131, 8767.605457754416, 8883.244924181517, 3737.2621730895266, 4321.438213032348, 4483.0, 4524.5701658342405, 4534.569215924482, 1434.9713005740036, 1535.9616009599627, 1697.2362436903443, 1812.8640351973654, 1899.4396652987402, 839.9076101628816, 884.4737381258141, 889.3107841422819, 978.8531720242021, 1059.9735006624896, 18866.811331886507, 20106.597868042558, 20145.697814532792, 20293.957539466697, 20360.981950902395, 965.971020869375, 974.5273542331963, 974.6393834281362, 1005.0903931941605, 1019.3170575714289, 10380.792384152426, 10565.9471702641, 10610.787784244272, 10653.89346106529, 10654.0, 443873.0, 496165.0, 506708.0, 522943.0, 531617.0, 99943.0, 108290.0, 108558.3716244257, 114041.85958140313, 117513.0, 816.3346872299176, 976.2677991506371, 1004.0762498501397, 1016.5019140621042, 1019.179560453827, 13571.1857288563, 14440.638984025483, 17748.467545973126, 17759.289628414717, 17825.197866095798, 51382.48617513777, 52331.0, 52449.737751311, 53756.0, 55729.0, 71951.0, 73896.0, 74780.0, 74784.0, 77238.0, 7790.14308426084, 7844.797951364834, 7893.960530197312, 7909.841803164019, 7913.129555748748, 10518.895515971019, 12158.635240942785, 12929.806052909025, 13294.401751920994, 13316.334183290603, 11183.161262905152, 11183.72040698989, 11193.880611938741, 11250.718732031764, 11661.0, 8988.86516702263, 11189.216754827085, 11204.887951120385, 11423.257488263236, 11742.060635149339, 9020.774480638036, 10906.61826836057, 11407.973282404624, 11501.137414693763, 11818.113641476752, 7532.397408207221, 8017.318527924958, 8156.673733050611, 8157.265846073882, 8364.456310339809, 10863.837042444211, 11000.944995274973, 11150.386728729998, 11159.163062770162, 11169.38568378747], "unit": "score", "name": "jquery.html", "value": 9174.195332673089}, {"lowerIsBetter": false, "replicates": [1537.9000364976275, 1564.8748100151986, 1805.8532831651905, 1922.0870086708824, 1924.894130822804, 7812.0, 8420.915790842106, 8588.8711669325, 8792.329457403097, 8830.514321712304, 8529.53087580183, 8576.927884014498, 8675.783105422368, 8701.347398945089, 8713.520756358397, 2297.4600968772324, 2299.4366380236825, 2300.2409204962323, 2321.245595181564, 2324.837261391695, 2391.6053851114543, 2412.457197130649, 2469.3579669286023, 2475.4306509502735, 2475.8638274894874, 2434.3427274635837, 2446.804255659552, 2451.105346548506, 2488.154027630605, 2492.2024952015363, 2021.706852506393, 2190.441437433444, 2467.962980555293, 2479.7024357077084, 2480.987595062013, 2435.4641978764644, 2453.7546245375497, 2463.8275320727557, 2472.7403622619727, 2472.8021758259297, 6923.757668481579, 8047.839043219103, 8827.646894124291, 8847.557622118868, 8877.023527411979, 4381.539938306496, 5415.48552887475, 5437.755301011464, 5460.945390546123, 5477.452254774531, 2969.9851500742575, 3063.356695094033, 3637.7635453695425, 3684.0053185639727, 3707.35121353762, 973.6689525561272, 987.8073775613758, 1058.751193469534, 1081.7181639756914, 1099.6206308823444, 10396.324238924446, 10580.047795698347, 11693.889080537336, 11741.530338786439, 11751.001164900994, 4753.33453316536, 4803.879903002453, 4891.633127515451, 4892.902141957212, 4894.412670479565, 9968.750781230527, 10068.295219334723, 10073.798524029478, 10077.143442807443, 10117.544710488046, 5407.513323800798, 5445.727713614304, 5447.046766815792, 5465.9180112298345, 5513.145462453326, 4400.405945197357, 4818.566329030334, 4902.240152776325, 4932.161532539477, 4980.726060066659, 3817.484639573622, 3895.2793733159456, 3896.7661940283674, 3917.980410097988, 3943.684505239574, 1287.2083668543964, 1301.694101886056, 1301.9739605208033, 1308.13009348782, 1309.9279539625222, 1306.9477220911247, 1346.9057165998481, 1349.8785109340206, 1357.864213578654, 1367.6102310841363, 8000.51996880189, 8163.061247956561, 8196.30331421824, 8207.0, 8233.34133269337, 512.4260827872806, 516.7287174233558, 520.7682581251307, 522.2427480153792, 524.7140308531859, 6204.81385558434, 6206.410391012847, 6245.125682404467, 6285.717142728588, 6288.465480434123, 10433.061024507831, 10861.565537378416, 10878.564857405774, 10915.945420272848, 10949.726256843642, 10521.631742888962, 10699.197560183018, 10723.30298530593, 10782.137429005661, 10834.187435942336, 8258.380621453414, 8289.668413263522, 8377.916220837835, 8383.748487545383, 8407.95796021016, 7797.376209903081, 7801.804954875946, 7815.10126335456, 7820.296173344426, 7876.369890408868, 9503.952480237554, 9574.521273936414, 9628.18160456341, 9654.469004204837, 9696.806063878541, 9720.805583888425, 9911.752206194902, 9979.351342162736, 10090.142337901361, 10165.0, 6619.172603424572, 7019.6841142147705, 7313.890291645736, 7476.5514069156025, 7479.626018699152, 8066.798330041796, 8100.594970251582, 8141.307988821017, 8150.184981501802, 8182.22268884455, 7156.534825236343, 7217.025701530436, 7248.746293879689, 7348.632568371453, 7414.555126692416, 7072.3988460979335, 7201.279872012967, 7218.27817218274, 7230.9638451807405, 7281.381082608038, 7588.544687318778, 7651.426143039405, 7686.116096648733, 7688.730894418669, 7765.922340776746, 6867.484938629723, 6901.930980690129, 6981.5112942093565, 6982.057422247932, 7003.824904377431, 7007.509474336747, 7047.506674532733, 7087.645617719197, 7101.0, 7148.106486689164], "unit": "score", "name": "mootools.html", "value": 4803.450482073452}, {"lowerIsBetter": false, "replicates": [284.4836621531919, 325.580001797681, 329.9076258647578, 330.97186739127176, 334.20459306849693, 6661.433778128859, 6709.597424154542, 6710.664466776666, 6738.528303018785, 6782.016607591902, 5567.6659400436, 6605.636689982061, 6607.438367738748, 6658.633775142365, 6696.397324240817, 4585.220512512864, 4792.9281060784115, 4920.0159968006365, 4930.6055515558755, 4944.590791624388, 4556.0, 4580.839670611529, 4846.127697014536, 4903.950960490403, 4943.728094954776, 4837.588804951566, 4872.610191184696, 4890.73100979446, 4895.388076490439, 4900.921797204627, 4870.707757534542, 4876.97561512192, 4900.460949295574, 4908.9754551227015, 4953.554180123806, 4159.230542349645, 4162.125953549758, 4162.500499940026, 4162.937555936664, 4181.849991252399, 6109.266887973472, 6340.302566717657, 6364.681765911686, 6376.681165941731, 6393.968030159819, 4678.906421871544, 4692.0, 5826.912596311059, 5847.356790753014, 5869.7945571904775, 7053.89419158713, 7099.645017749143, 7115.501914865961, 7116.110486189226, 7118.893216601755, 4670.182718024332, 4681.672282940195, 4687.062587482517, 4692.389989301369, 4696.412948381452, 6011.939880601181, 7540.660670269851, 7543.509671871366, 7571.886421703679, 7593.696252149907, 4665.743384113838, 4786.880327991758, 4795.712257264506, 4797.40032495938, 4845.878853028632, 4889.119958407521, 4927.285543596158, 4943.5797957174045, 4951.702897826142, 4959.107360675041, 4411.0, 5312.963972025418, 5800.332961709373, 5820.592558520862, 5843.948089343959, 5820.854478637983, 7294.817629559304, 7306.050213472215, 7320.5607663539295, 7332.156801967735, 1698.9320427182774, 1727.4472168906082, 1731.0, 1734.5663584103975, 1735.1671197825115, 1089.1178145702006, 1120.8542889424323, 1128.2722643894642, 1135.9204855660025, 1146.9655910322538, 6646.8005959821285, 6660.134182556237, 6682.933170668328, 6685.465162787063, 6706.094677218611, 7428.517146385576, 7429.294217049372, 7452.441066920002, 7462.179160292363, 7489.550626962399, 6441.3880681335195, 6564.409203171642, 6642.734290628321, 6653.534252602271, 6756.223034351015, 3884.9611503885167, 3942.9605703943166, 3942.9605703943166, 3943.2704949584418, 3952.7628342299554, 7840.059192896889, 7841.294283514511, 7844.254795794391, 7854.8429031419055, 7872.094709108412, 7718.228177182237, 7719.807004824812, 7724.7682569523, 7766.495177813424, 7775.766726998199, 7589.848203035908, 7871.803204919808, 7899.684012639545, 7921.683132674743, 7976.322012628875, 6040.244969378828, 6046.969765151146, 6765.729370825112, 7443.0, 7560.281773231534, 7443.590602516913, 7444.994925684963, 7448.031755871702, 7461.4403919705155, 7485.288897554724, 7693.615319233904, 7853.489523181203, 7887.921120788718, 7937.484063535851, 7949.642266097924, 3883.0, 4639.907201855876, 4643.442786865598, 4691.929621055619, 4715.363425937455, 7520.623968801648, 7526.811829704301, 7552.773416797505, 7577.810554736176, 7589.544627322378, 7228.457865660202, 7265.963670181826, 7276.0, 7281.526700764433, 7309.890351644836, 6980.720771169096, 7231.746888858865, 7253.274672532704, 7258.49190556656, 7291.2293328534815, 7028.929710702828, 7081.114860642419, 7089.113860767404, 7094.1909812997355, 7118.5017048806085, 5356.651817631841, 7131.286871313035, 7249.601271929883, 7272.709091636275, 7290.781276561712, 6005.87988240224, 6804.741122892281, 7058.364747172779, 7105.3960413363375, 7126.536775109601], "unit": "score", "name": "prototype.html", "value": 5215.2216233778945}, {"lowerIsBetter": false, "replicates": [686.9862602747944, 718.7735863203087, 742.8885667149926, 749.3293502315424, 750.5084169868738, 14914.776278355834, 14926.253687315631, 15045.6990860183, 15096.77354839677, 15227.162506062175, 13362.66593335167, 13443.1261967972, 13457.46170153195, 13492.392842322095, 13541.322933853293, 696.5994553131944, 841.4993079117914, 842.1326034184799, 852.0116664668985, 853.3855623950776, 832.7460124661976, 845.8519759042174, 848.2323497234981, 851.4635779458932, 856.2165618459103, 899.0964081098487, 914.38279161566, 922.1331947968921, 925.0795458518784, 934.0332755597957, 892.486820078451, 901.1934318784716, 902.8645703144548, 906.3021473465427, 913.0686699566438, 674.2919934069208, 679.2935347238915, 685.8936864785966, 686.9690863911136, 690.2752110284182, 14843.332050057774, 14922.776158357634, 14954.177520236492, 14965.551033469013, 15009.774853377208, 12596.181248218836, 12649.557265495756, 12699.555515557004, 12854.614361569167, 12861.099723019392, 9897.604095836157, 10132.24008199388, 10173.694789156338, 10233.181345492343, 10543.578256869716, 3550.609432962372, 3551.0, 3554.3424466473784, 3587.4260118380935, 3644.9817750911343, 61922.0, 80929.0, 81836.59081704554, 82578.0, 82909.75635365474, 9359.391639543408, 9365.391249568756, 9485.4782986935, 9578.56896439662, 9652.27607929408, 17875.838070525373, 19167.233310667416, 20304.0, 20362.28731994373, 20388.490287742927, 6079.0, 7482.5884576347735, 7483.064616922885, 7575.204603516661, 7582.431317651198, 4104.384342348671, 4182.309918863353, 4199.160167966419, 4209.052963083343, 4209.473815773028, 3545.982270088685, 3548.414511605608, 3578.910527236788, 3587.802670853076, 3587.8564857405413, 649.3506493506494, 649.7206201333472, 659.0608383054129, 661.7286912366003, 663.2604645819877, 579.4321564866455, 591.8695291992274, 610.1732152932801, 611.2176414189844, 650.606383138204, 7706.807329816799, 8192.34461243099, 8240.093589705128, 8384.610386039949, 8430.915690843136, 496.18873142412417, 527.2565682387815, 553.8559974406684, 579.982600521985, 595.6336852835475, 3860.8069596520063, 3863.555691095504, 3888.5916978716828, 3909.9834043148417, 3963.8612648557164, 85444.57277713572, 86908.0, 86974.13025869787, 87127.0, 88442.67335989965, 53877.73061134669, 65822.0, 75131.24868751352, 75463.62268188734, 76058.47883042308, 63606.0, 66183.66908165428, 66854.66290674257, 68509.0, 68921.65539172271, 6427.807165785034, 8266.8370556388, 8323.6670533178, 8357.331413486785, 8565.146450175143, 35551.267116952346, 41060.79469602633, 47566.28650570175, 49332.75333623309, 50751.746241268556, 66200.66899665663, 66673.33316667122, 67922.66038669775, 68018.63962720618, 71004.64497677685, 10778.784424311627, 10801.513931873242, 10905.945470272598, 11137.610183643534, 11731.061515078603, 11980.700482488008, 12200.0, 12364.1963272387, 12389.75220495603, 12437.440315185657, 11339.149563782585, 11356.676675683184, 11459.713507162387, 11494.252873563191, 11919.284842909454, 11086.279391839505, 11487.712807179887, 11499.770004599693, 11786.76426471483, 11923.642290731292, 11111.999200719418, 11231.15766317513, 11235.382053986783, 11239.269447485887, 11617.941910290394, 9018.729438116867, 9383.624655013722, 9389.765255868659, 9535.38020028696, 9608.95195524018, 9490.098440648128, 9757.756056098655, 9765.121139097515, 9776.608935642778, 9800.313978021755], "unit": "score", "name": "yui.html", "value": 6774.934667541044}], "name": "dromaeo_css", "value": 7399.341471569947}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 111.0, 120.0, 114.0, 115.0, 123.0, 114.0, 114.0, 116.0, 113.0], "unit": "score", "name": "ai-astar", "value": 115.4}, {"lowerIsBetter": true, "replicates": [151.0, 108.0, 163.0, 170.0, 147.0, 172.0, 173.0, 124.0, 194.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 152.4}, {"lowerIsBetter": true, "replicates": [196.0, 199.0, 199.0, 202.0, 204.0, 257.0, 214.0, 281.0, 220.0, 199.0], "unit": "score", "name": "audio-dft", "value": 217.1}, {"lowerIsBetter": true, "replicates": [70.0, 76.0, 73.0, 113.0, 58.0, 57.0, 57.0, 59.0, 132.0, 72.0], "unit": "score", "name": "audio-fft", "value": 76.7}, {"lowerIsBetter": true, "replicates": [82.0, 80.0, 105.0, 109.0, 119.0, 121.0, 145.0, 61.0, 111.0, 158.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [85.0, 92.0, 85.0, 92.0, 87.0, 90.0, 85.0, 114.0, 130.0, 88.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.8}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 96.0, 94.0, 95.0, 94.0, 96.0, 95.0, 95.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 94.7}, {"lowerIsBetter": true, "replicates": [106.0, 148.0, 149.0, 92.0, 92.0, 94.0, 92.0, 92.0, 91.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 104.8}, {"lowerIsBetter": true, "replicates": [60.0, 59.0, 60.0, 56.0, 57.0, 56.0, 57.0, 68.0, 58.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 58.9}, {"lowerIsBetter": true, "replicates": [65.0, 74.0, 70.0, 91.0, 117.0, 107.0, 88.0, 68.0, 69.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 82.0}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 86.0, 87.0, 88.0, 85.0, 85.0, 89.0, 91.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.1}, {"lowerIsBetter": true, "replicates": [130.0, 129.0, 128.0, 123.0, 130.0, 143.0, 138.0, 133.0, 140.0, 142.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 133.6}, {"lowerIsBetter": true, "replicates": [147.0, 142.0, 142.0, 143.0, 149.0, 142.0, 143.0, 139.0, 137.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 67.0, 68.0, 69.0, 88.0, 63.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken", "value": 1539.6}]} 01:21:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1539.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7399.34"}}} 01:21:06 INFO - Return code: 0 01:21:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:21:06 ERROR - # TBPL SUCCESS # 01:21:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:21:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:21:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:21:06 INFO - 2016-02-26 01:21:06.529 screenresolution[1698:10663] starting screenresolution argv=screenresolution get 01:21:06 INFO - 2016-02-26 01:21:06.532 screenresolution[1698:10663] Display 0: 1600x1200x32@60 01:21:06 INFO - 2016-02-26 01:21:06.538 screenresolution[1699:10666] starting screenresolution argv=screenresolution list 01:21:06 INFO - Available Modes on Display 0 01:21:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:21:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:21:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:21:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:21:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:21:06 INFO - Intel Iris: 01:21:06 INFO - Chipset Model: Intel Iris 01:21:06 INFO - Type: GPU 01:21:06 INFO - Bus: Built-In 01:21:06 INFO - VRAM (Dynamic, Max): 1536 MB 01:21:06 INFO - Vendor: Intel (0x8086) 01:21:06 INFO - Device ID: 0x0a2e 01:21:06 INFO - Revision ID: 0x0009 01:21:06 INFO - Displays: 01:21:06 INFO - Display: 01:21:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:21:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:21:06 INFO - Display Serial Number: 1600x1200 60 01:21:06 INFO - Main Display: Yes 01:21:06 INFO - Mirror: Off 01:21:06 INFO - Online: Yes 01:21:06 INFO - Rotation: Supported 01:21:06 INFO - Return code: 0 01:21:06 INFO - Running post-action listener: _resource_record_post_action 01:21:06 INFO - Running post-run listener: _resource_record_post_run 01:21:07 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 33631744; Write bytes: 711606784; Read time: 347; Write time: 2278 01:21:07 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404419072; Write bytes: 405116928; Read time: 30206; Write time: 714 01:21:07 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 31849984; Write bytes: 304830976; Read time: 328; Write time: 1558 01:21:07 INFO - Running post-run listener: _upload_blobber_files 01:21:07 INFO - Blob upload gear active. 01:21:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:21:07 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:21:07 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:21:07 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:21:08 INFO - (blobuploader) - INFO - Open directory for files ... 01:21:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:21:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:21:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:21:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:21:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:21:09 INFO - (blobuploader) - INFO - Done attempting. 01:21:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:21:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:21:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:21:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:21:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:21:10 INFO - (blobuploader) - INFO - Done attempting. 01:21:10 INFO - (blobuploader) - INFO - Iteration through files over. 01:21:10 INFO - Return code: 0 01:21:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:21:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:21:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/27437a59dcdd54b6fb65074a46287013caedd169fe86248b3bd748640fd701804328728634d7ab2178a3c85b1f7b243c204ac27337f43d2d2c29159e8afb02d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71fac12a36fe1fe67ac50518d49ecb3799a4ed74bd9610f8f76fe05072089acd1f8d522ac071bb1426c4d1cfcaa98656e691d1bb9ad2fcce7d97fe1fb7ee0b6a"} 01:21:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:21:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:21:10 INFO - Contents: 01:21:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/27437a59dcdd54b6fb65074a46287013caedd169fe86248b3bd748640fd701804328728634d7ab2178a3c85b1f7b243c204ac27337f43d2d2c29159e8afb02d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71fac12a36fe1fe67ac50518d49ecb3799a4ed74bd9610f8f76fe05072089acd1f8d522ac071bb1426c4d1cfcaa98656e691d1bb9ad2fcce7d97fe1fb7ee0b6a"} 01:21:10 INFO - Running post-run listener: copy_logs_to_upload_dir 01:21:10 INFO - Copying logs to upload dir... 01:21:10 INFO - mkdir: /builds/slave/test/build/upload/logs 01:21:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.314804 ========= master_lag: 11.65 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-02-26 01:21:21.715518) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 01:21:21.719897) ========= 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.7s78tnYoyA/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.2BYoyqWfig/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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/27437a59dcdd54b6fb65074a46287013caedd169fe86248b3bd748640fd701804328728634d7ab2178a3c85b1f7b243c204ac27337f43d2d2c29159e8afb02d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71fac12a36fe1fe67ac50518d49ecb3799a4ed74bd9610f8f76fe05072089acd1f8d522ac071bb1426c4d1cfcaa98656e691d1bb9ad2fcce7d97fe1fb7ee0b6a"} build_url:https://queue.taskcluster.net/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011188 build_url: 'https://queue.taskcluster.net/v1/task/JpXnOptXRHiB9cYkajRKJQ/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/27437a59dcdd54b6fb65074a46287013caedd169fe86248b3bd748640fd701804328728634d7ab2178a3c85b1f7b243c204ac27337f43d2d2c29159e8afb02d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71fac12a36fe1fe67ac50518d49ecb3799a4ed74bd9610f8f76fe05072089acd1f8d522ac071bb1426c4d1cfcaa98656e691d1bb9ad2fcce7d97fe1fb7ee0b6a"}' ========= master_lag: 0.87 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 01:21:22.601754) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 mins, 1 secs) (at 2016-02-26 01:21:22.602194) ========= 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.7s78tnYoyA/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.2BYoyqWfig/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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.005308 ========= master_lag: 61.66 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 mins, 1 secs) (at 2016-02-26 01:22:24.264473) ========= ========= Started reboot skipped (results: 3, elapsed: 5 secs) (at 2016-02-26 01:22:24.264775) ========= ========= Finished reboot skipped (results: 3, elapsed: 5 secs) (at 2016-02-26 01:22:29.753589) ========= ========= Total master_lag: 74.88 =========