builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0077 starttime: 1456477198.7 results: success (0) buildid: 20160226000943 builduid: 40c12cc108a9441486c516af198d6348 revision: a97d22a2418febbac21e5f6117046a3d739d5c5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 00:59:58.702991) ========= 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:58.703420) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 00:59:58.703738) ========= 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.O7P4Den0YK/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.ePFzkPTsbe/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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.005502 basedir: '/builds/slave/test' ========= master_lag: 0.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 00:59:58.796281) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 00:59:58.796634) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 00:59:59.584772) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 00:59:59.585103) ========= 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.O7P4Den0YK/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.ePFzkPTsbe/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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.005392 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 00:59:59.633919) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 00:59:59.634238) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 00:59:59.634644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 00:59:59.634976) ========= 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.O7P4Den0YK/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.ePFzkPTsbe/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 00:59:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 38.5M=0s 2016-02-26 00:59:59 (38.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.215159 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 00:59:59.925398) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 00:59:59.925739) ========= 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.O7P4Den0YK/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.ePFzkPTsbe/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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.027371 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 00:59:59.975573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-26 00:59:59.975947) ========= 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.O7P4Den0YK/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.ePFzkPTsbe/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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,054 truncating revision to first 12 chars 2016-02-26 01:00:00,054 Setting DEBUG logging. 2016-02-26 01:00:00,054 attempt 1/10 2016-02-26 01:00:00,054 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:02,033 unpacking tar archive at: fx-team-a97d22a2418f/testing/mozharness/ program finished with exit code 0 elapsedTime=2.225287 ========= master_lag: 0.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-26 01:00:02.377189) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 01:00:02.377565) ========= 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.O7P4Den0YK/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.ePFzkPTsbe/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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.006131 script_repo_revision: 'a97d22a2418febbac21e5f6117046a3d739d5c5a' ========= master_lag: 0.09 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 01:00:02.477574) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 01:00:02.477953) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 01:00:02.873485) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2016-02-26 01:00:02.873776) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.O7P4Den0YK/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.ePFzkPTsbe/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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:03 INFO - MultiFileLogger online at 20160226 01:00:03 in /builds/slave/test 01:00:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 01:00:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:00:03 INFO - {'append_to_log': False, 01:00:03 INFO - 'base_work_dir': '/builds/slave/test', 01:00:03 INFO - 'blob_upload_branch': 'Fx-Team', 01:00:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:00:03 INFO - 'branch': 'Fx-Team', 01:00:03 INFO - 'buildbot_json_path': 'buildprops.json', 01:00:03 INFO - 'config_files': ('talos/mac_config.py',), 01:00:03 INFO - 'default_actions': ('clobber', 01:00:03 INFO - 'read-buildbot-config', 01:00:03 INFO - 'download-and-extract', 01:00:03 INFO - 'populate-webroot', 01:00:03 INFO - 'create-virtualenv', 01:00:03 INFO - 'install', 01:00:03 INFO - 'run-tests'), 01:00:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:00:03 INFO - 'download_minidump_stackwalk': True, 01:00:03 INFO - 'download_symbols': 'ondemand', 01:00:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:00:03 INFO - 'tooltool.py': '/tools/tooltool.py', 01:00:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:00:03 INFO - '/tools/misc-python/virtualenv.py')}, 01:00:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:00:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:00:03 INFO - 'installer_path': 'installer.exe', 01:00:03 INFO - 'log_level': 'info', 01:00:03 INFO - 'log_name': 'talos', 01:00:03 INFO - 'log_to_console': True, 01:00:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:00:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:00:03 INFO - 'opt_config_files': (), 01:00:03 INFO - 'pip_index': False, 01:00:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:00:03 INFO - 'cmd': ('bash', 01:00:03 INFO - '-c', 01:00:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:00:03 INFO - 'enabled': True, 01:00:03 INFO - 'halt_on_failure': False, 01:00:03 INFO - 'name': 'check_screen_resolution'},), 01:00:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:00:03 INFO - 'cmd': ('bash', 01:00:03 INFO - '-c', 01:00:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:00:03 INFO - 'enabled': True, 01:00:03 INFO - 'halt_on_failure': False, 01:00:03 INFO - 'name': 'check_screen_resolution'},), 01:00:03 INFO - 'run_cmd_checks_enabled': True, 01:00:03 INFO - 'sps_profile': False, 01:00:03 INFO - 'sps_profile_interval': 0, 01:00:03 INFO - 'suite': 'dromaeojs', 01:00:03 INFO - 'system_bits': '32', 01:00:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:00:03 INFO - 'title': 't-yosemite-r7-0077', 01:00:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:00:03 INFO - 'use_talos_json': True, 01:00:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:00:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:00:03 INFO - 'work_dir': 'build'} 01:00:03 INFO - ##### 01:00:03 INFO - ##### Running clobber step. 01:00:03 INFO - ##### 01:00:03 INFO - Running pre-action listener: _resource_record_pre_action 01:00:03 INFO - Running main action method: clobber 01:00:03 INFO - rmtree: /builds/slave/test/build 01:00:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:00:05 INFO - Running post-action listener: _resource_record_post_action 01:00:05 INFO - ##### 01:00:05 INFO - ##### Running read-buildbot-config step. 01:00:05 INFO - ##### 01:00:05 INFO - Running pre-action listener: _resource_record_pre_action 01:00:05 INFO - Running main action method: read_buildbot_config 01:00:05 INFO - Using buildbot properties: 01:00:05 INFO - { 01:00:05 INFO - "project": "", 01:00:05 INFO - "product": "firefox", 01:00:05 INFO - "script_repo_revision": "production", 01:00:05 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 01:00:05 INFO - "repository": "", 01:00:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 01:00:05 INFO - "buildid": "20160226000943", 01:00:05 INFO - "pgo_build": "False", 01:00:05 INFO - "basedir": "/builds/slave/test", 01:00:05 INFO - "buildnumber": 416, 01:00:05 INFO - "slavename": "t-yosemite-r7-0077", 01:00:05 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 01:00:05 INFO - "platform": "yosemite_r7", 01:00:05 INFO - "scheduler": "tests-fx-team-macosx64-talos", 01:00:05 INFO - "branch": "fx-team", 01:00:05 INFO - "repo_path": "integration/fx-team", 01:00:05 INFO - "revision": "a97d22a2418febbac21e5f6117046a3d739d5c5a", 01:00:05 INFO - "stage_platform": "macosx64", 01:00:05 INFO - "builduid": "40c12cc108a9441486c516af198d6348", 01:00:05 INFO - "slavebuilddir": "test" 01:00:05 INFO - } 01:00:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 01:00:05 INFO - Running post-action listener: _resource_record_post_action 01:00:05 INFO - ##### 01:00:05 INFO - ##### Running download-and-extract step. 01:00:05 INFO - ##### 01:00:05 INFO - Running pre-action listener: _resource_record_pre_action 01:00:05 INFO - Running main action method: download_and_extract 01:00:05 INFO - mkdir: /builds/slave/test/build/tests 01:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:05 INFO - https://queue.taskcluster.net/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:00:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/test_packages.json 01:00:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/test_packages.json 01:00:05 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:05 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:18 INFO - Downloaded 1277 bytes. 01:00:18 INFO - Reading from file /builds/slave/test/build/test_packages.json 01:00:18 INFO - Using the following test package requirements: 01:00:18 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:00:18 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:00:18 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 01:00:18 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:00:18 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 01:00:18 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:00:18 INFO - u'jsshell-mac.zip'], 01:00:18 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:00:18 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 01:00:18 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:00:18 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:00:18 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 01:00:18 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:00:18 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 01:00:18 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:00:18 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 01:00:18 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:00:18 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:00:18 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 01:00:18 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:00:18 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:18 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:18 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:18 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:18 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:18 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:20 INFO - Downloaded 17830419 bytes. 01:00:20 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:20 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:23 INFO - Return code: 0 01:00:23 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:23 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:23 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:23 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:23 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:23 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:23 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:33 INFO - Downloaded 17830419 bytes. 01:00:33 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:33 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:37 INFO - Return code: 0 01:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:37 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:37 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:37 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:37 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:37 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:38 INFO - Downloaded 10713410 bytes. 01:00:38 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:38 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:38 INFO - Return code: 0 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 - https://queue.taskcluster.net/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:00:38 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:38 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:38 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:38 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:44 INFO - Downloaded 111439516 bytes. 01:00:44 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:44 INFO - mkdir: /builds/slave/test/properties 01:00:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:00:44 INFO - Writing to file /builds/slave/test/properties/build_url 01:00:44 INFO - Contents: 01:00:44 INFO - build_url:https://queue.taskcluster.net/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:00:45 INFO - Running post-action listener: _resource_record_post_action 01:00:45 INFO - Running post-action listener: set_extra_try_arguments 01:00:45 INFO - ##### 01:00:45 INFO - ##### Running populate-webroot step. 01:00:45 INFO - ##### 01:00:45 INFO - Running pre-action listener: _resource_record_pre_action 01:00:45 INFO - Running main action method: populate_webroot 01:00:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:00:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:00:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:00:45 INFO - '--tppagecycles', 01:00:45 INFO - '7'], 01:00:45 INFO - 'tests': ['tsvgm']}}, 01:00:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:00:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:00:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:00:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:00:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:00:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:00:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:00:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:45 INFO - 'talos_options': ['--e10s'], 01:00:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:00:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:45 INFO - 'tests': ['damp', 'tps']}, 01:00:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:45 INFO - 'talos_options': ['--e10s'], 01:00:45 INFO - 'tests': ['damp', 'tps']}, 01:00:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:00:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:00:45 INFO - 'other': {'tests': ['a11yr', 01:00:45 INFO - 'ts_paint', 01:00:45 INFO - 'tpaint', 01:00:45 INFO - 'sessionrestore', 01:00:45 INFO - 'sessionrestore_no_auto_restore']}, 01:00:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:00:45 INFO - 'tests': ['a11yr', 01:00:45 INFO - 'ts_paint', 01:00:45 INFO - 'tpaint', 01:00:45 INFO - 'sessionrestore', 01:00:45 INFO - 'sessionrestore_no_auto_restore']}, 01:00:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:00:45 INFO - 'tests': ['a11yr', 01:00:45 INFO - 'ts_paint', 01:00:45 INFO - 'tpaint', 01:00:45 INFO - 'sessionrestore', 01:00:45 INFO - 'sessionrestore_no_auto_restore']}, 01:00:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:00:45 INFO - 'tests': ['a11yr', 01:00:45 INFO - 'ts_paint', 01:00:45 INFO - 'tpaint', 01:00:45 INFO - 'sessionrestore', 01:00:45 INFO - 'sessionrestore_no_auto_restore']}, 01:00:45 INFO - 'other_l64': {'tests': ['a11yr', 01:00:45 INFO - 'ts_paint', 01:00:45 INFO - 'tpaint', 01:00:45 INFO - 'sessionrestore', 01:00:45 INFO - 'sessionrestore_no_auto_restore']}, 01:00:45 INFO - 'other_nol64': {'tests': ['a11yr', 01:00:45 INFO - 'ts_paint', 01:00:45 INFO - 'tpaint', 01:00:45 INFO - 'sessionrestore', 01:00:45 INFO - 'sessionrestore_no_auto_restore']}, 01:00:45 INFO - 'svgr': {'tests': ['tsvgx', 01:00:45 INFO - 'tsvgr_opacity', 01:00:45 INFO - 'tart', 01:00:45 INFO - 'tscrollx', 01:00:45 INFO - 'cart']}, 01:00:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:00:45 INFO - 'tests': ['tsvgx', 01:00:45 INFO - 'tsvgr_opacity', 01:00:45 INFO - 'tart', 01:00:45 INFO - 'tscrollx', 01:00:45 INFO - 'cart']}, 01:00:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:45 INFO - 'tests': ['tp5o']}, 01:00:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:45 INFO - 'talos_options': ['--e10s'], 01:00:45 INFO - 'tests': ['tp5o']}, 01:00:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:45 INFO - 'talos_options': ['--xperf_path', 01:00:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:00:45 INFO - 'tests': ['tp5n']}, 01:00:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:45 INFO - 'talos_options': ['--e10s', 01:00:45 INFO - '--xperf_path', 01:00:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:00:45 INFO - 'tests': ['tp5n']}}, 01:00:45 INFO - 'talos.zip': {'path': '', 01:00:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:00:45 INFO - Running post-action listener: _resource_record_post_action 01:00:45 INFO - ##### 01:00:45 INFO - ##### Running create-virtualenv step. 01:00:45 INFO - ##### 01:00:45 INFO - Running pre-action listener: _resource_record_pre_action 01:00:45 INFO - Running main action method: create_virtualenv 01:00:45 INFO - Creating virtualenv /builds/slave/test/build/venv 01:00:45 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:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:00:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:00:45 INFO - Using real prefix '/tools/python27' 01:00:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:00:46 INFO - Installing distribute.............................................................................................................................................................................................done. 01:00:49 INFO - Installing pip.................done. 01:00:49 INFO - Return code: 0 01:00:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107c15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c1d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc439d8ad80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ab9d30>, '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 0x1078dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ab0b20>, '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.O7P4Den0YK/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.ePFzkPTsbe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:00:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:00:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O7P4Den0YK/Render', 01:00:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:49 INFO - 'HOME': '/Users/cltbld', 01:00:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:49 INFO - 'LOGNAME': 'cltbld', 01:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:49 INFO - 'MOZ_NO_REMOTE': '1', 01:00:49 INFO - 'NO_EM_RESTART': '1', 01:00:49 INFO - 'PAGER': '/bin/cat', 01:00:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:49 INFO - 'PWD': '/builds/slave/test', 01:00:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:49 INFO - 'SHELL': '/bin/bash', 01:00:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ePFzkPTsbe/Listeners', 01:00:49 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 01:00:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:49 INFO - 'USER': 'cltbld', 01:00:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:49 INFO - 'XPC_FLAGS': '0x0', 01:00:49 INFO - 'XPC_SERVICE_NAME': '0', 01:00:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:49 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:49 INFO - Cleaning up... 01:00:49 INFO - Return code: 0 01:00:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107c15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c1d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc439d8ad80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ab9d30>, '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 0x1078dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ab0b20>, '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.O7P4Den0YK/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.ePFzkPTsbe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:00:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:00:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O7P4Den0YK/Render', 01:00:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:49 INFO - 'HOME': '/Users/cltbld', 01:00:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:49 INFO - 'LOGNAME': 'cltbld', 01:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:49 INFO - 'MOZ_NO_REMOTE': '1', 01:00:49 INFO - 'NO_EM_RESTART': '1', 01:00:49 INFO - 'PAGER': '/bin/cat', 01:00:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:49 INFO - 'PWD': '/builds/slave/test', 01:00:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:49 INFO - 'SHELL': '/bin/bash', 01:00:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ePFzkPTsbe/Listeners', 01:00:49 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 01:00:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:49 INFO - 'USER': 'cltbld', 01:00:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:49 INFO - 'XPC_FLAGS': '0x0', 01:00:49 INFO - 'XPC_SERVICE_NAME': '0', 01:00:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:49 INFO - Downloading/unpacking psutil>=0.7.1 01:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:00:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:00:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:00:53 INFO - Installing collected packages: psutil 01:00:53 INFO - Running setup.py install for psutil 01:00:53 INFO - building 'psutil._psutil_osx' extension 01:00:53 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:53 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:53 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:53 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:54 INFO - building 'psutil._psutil_posix' extension 01:00:54 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:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:00:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:00:54 INFO - ^ 01:00:54 INFO - 1 warning generated. 01:00:54 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:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:00:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:00:54 INFO - Successfully installed psutil 01:00:54 INFO - Cleaning up... 01:00:54 INFO - Return code: 0 01:00:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:00:54 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:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:54 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:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:54 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 0x107c15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c1d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc439d8ad80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ab9d30>, '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 0x1078dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ab0b20>, '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.O7P4Den0YK/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.ePFzkPTsbe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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:54 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:54 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:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O7P4Den0YK/Render', 01:00:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:54 INFO - 'HOME': '/Users/cltbld', 01:00:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:54 INFO - 'LOGNAME': 'cltbld', 01:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:54 INFO - 'MOZ_NO_REMOTE': '1', 01:00:54 INFO - 'NO_EM_RESTART': '1', 01:00:54 INFO - 'PAGER': '/bin/cat', 01:00:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:54 INFO - 'PWD': '/builds/slave/test', 01:00:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:54 INFO - 'SHELL': '/bin/bash', 01:00:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ePFzkPTsbe/Listeners', 01:00:54 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 01:00:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:54 INFO - 'USER': 'cltbld', 01:00:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:54 INFO - 'XPC_FLAGS': '0x0', 01:00:54 INFO - 'XPC_SERVICE_NAME': '0', 01:00:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:00:57 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:57 INFO - Installing collected packages: mozsystemmonitor 01:00:57 INFO - Running setup.py install for mozsystemmonitor 01:00:57 INFO - Successfully installed mozsystemmonitor 01:00:57 INFO - Cleaning up... 01:00:57 INFO - Return code: 0 01:00:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:00:57 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:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:57 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:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:57 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 0x107c15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c1d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc439d8ad80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ab9d30>, '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 0x1078dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ab0b20>, '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.O7P4Den0YK/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.ePFzkPTsbe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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:57 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:57 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:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O7P4Den0YK/Render', 01:00:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:57 INFO - 'HOME': '/Users/cltbld', 01:00:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:57 INFO - 'LOGNAME': 'cltbld', 01:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:57 INFO - 'MOZ_NO_REMOTE': '1', 01:00:57 INFO - 'NO_EM_RESTART': '1', 01:00:57 INFO - 'PAGER': '/bin/cat', 01:00:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:57 INFO - 'PWD': '/builds/slave/test', 01:00:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:57 INFO - 'SHELL': '/bin/bash', 01:00:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ePFzkPTsbe/Listeners', 01:00:57 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 01:00:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:57 INFO - 'USER': 'cltbld', 01:00:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:57 INFO - 'XPC_FLAGS': '0x0', 01:00:57 INFO - 'XPC_SERVICE_NAME': '0', 01:00:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:57 INFO - Downloading/unpacking blobuploader==1.2.4 01:00:57 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:57 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:57 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:57 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:57 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:57 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 blobuploader-1.2.4.tar.gz 01:00:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:00:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 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 - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:01:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 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:01 INFO - Downloading docopt-0.6.1.tar.gz 01:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:01:01 INFO - Installing collected packages: blobuploader, requests, docopt 01:01:01 INFO - Running setup.py install for blobuploader 01:01:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:01:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:01:01 INFO - Running setup.py install for requests 01:01:01 INFO - Running setup.py install for docopt 01:01:02 INFO - Successfully installed blobuploader requests docopt 01:01:02 INFO - Cleaning up... 01:01:02 INFO - Return code: 0 01:01:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:02 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 0x107c15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c1d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc439d8ad80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ab9d30>, '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 0x1078dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ab0b20>, '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.O7P4Den0YK/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.ePFzkPTsbe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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:01:02 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:01:02 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:01:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O7P4Den0YK/Render', 01:01:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:01:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:01:02 INFO - 'HOME': '/Users/cltbld', 01:01:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:01:02 INFO - 'LOGNAME': 'cltbld', 01:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:02 INFO - 'MOZ_NO_REMOTE': '1', 01:01:02 INFO - 'NO_EM_RESTART': '1', 01:01:02 INFO - 'PAGER': '/bin/cat', 01:01:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:02 INFO - 'PWD': '/builds/slave/test', 01:01:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:01:02 INFO - 'SHELL': '/bin/bash', 01:01:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ePFzkPTsbe/Listeners', 01:01:02 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 01:01:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:01:02 INFO - 'USER': 'cltbld', 01:01:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:01:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:02 INFO - 'XPC_FLAGS': '0x0', 01:01:02 INFO - 'XPC_SERVICE_NAME': '0', 01:01:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:01:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:01:02 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-72MFyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:01:02 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-8L5IhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:01:02 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-XcRX_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:01:02 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-_M2fMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:01:02 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-xyCpJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:01:02 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-ZXqXTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:01:03 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-8YLLo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:01:03 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-Y5ozaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:01:03 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-aET3bi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:01:03 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-0eCc9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:01:03 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-OEb3Tk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:01:03 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-Znj9Jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:01:03 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-dfiTcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:01:03 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-L1IN8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:01:03 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-QQZgwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:01:03 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-eupwA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:01:04 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-OrIyua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:01:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:01:04 INFO - Running setup.py install for manifestparser 01:01:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:01:04 INFO - Running setup.py install for mozcrash 01:01:04 INFO - Running setup.py install for mozdebug 01:01:04 INFO - Running setup.py install for mozdevice 01:01:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:01:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:01:04 INFO - Running setup.py install for mozfile 01:01:04 INFO - Running setup.py install for mozhttpd 01:01:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:01:05 INFO - Running setup.py install for mozinfo 01:01:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:01:05 INFO - Running setup.py install for mozInstall 01:01:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:01:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:01:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:01:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:01:05 INFO - Running setup.py install for mozleak 01:01:05 INFO - Running setup.py install for mozlog 01:01:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:01:05 INFO - Running setup.py install for moznetwork 01:01:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:01:05 INFO - Running setup.py install for mozprocess 01:01:05 INFO - Running setup.py install for mozprofile 01:01:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:01:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:01:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:01:06 INFO - Running setup.py install for mozrunner 01:01:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:01:06 INFO - Running setup.py install for mozscreenshot 01:01:06 INFO - Running setup.py install for moztest 01:01:06 INFO - Running setup.py install for mozversion 01:01:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:01:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:01:06 INFO - Cleaning up... 01:01:06 INFO - Return code: 0 01:01:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:07 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 0x107c15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c1d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc439d8ad80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ab9d30>, '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 0x1078dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ab0b20>, '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.O7P4Den0YK/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.ePFzkPTsbe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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:01:07 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:01:07 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:01:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O7P4Den0YK/Render', 01:01:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:01:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:01:07 INFO - 'HOME': '/Users/cltbld', 01:01:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:01:07 INFO - 'LOGNAME': 'cltbld', 01:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:07 INFO - 'MOZ_NO_REMOTE': '1', 01:01:07 INFO - 'NO_EM_RESTART': '1', 01:01:07 INFO - 'PAGER': '/bin/cat', 01:01:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:07 INFO - 'PWD': '/builds/slave/test', 01:01:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:01:07 INFO - 'SHELL': '/bin/bash', 01:01:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ePFzkPTsbe/Listeners', 01:01:07 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 01:01:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:01:07 INFO - 'USER': 'cltbld', 01:01:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:01:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:07 INFO - 'XPC_FLAGS': '0x0', 01:01:07 INFO - 'XPC_SERVICE_NAME': '0', 01:01:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:01:07 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-_5ZHy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:01:07 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:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:01:07 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-AEUbyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:01:07 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:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:01:07 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-S1smWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:01:07 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:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:01:07 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-EsCLq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:01:07 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:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:01:07 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-pxjUhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:01:08 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:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:01:08 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-FoRn9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:01:08 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:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:01:08 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-t58op0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:01:08 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:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:01:08 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-dGyGkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:01:08 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:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:01:08 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-hx1dq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:01:08 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:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:01:08 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-Ui2kRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:01:08 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:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:01:08 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-HYKtVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:01:08 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:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:01:08 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-wDPy2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:01:08 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:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:01:08 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-EJkTab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:01:08 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:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:01:08 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-j2S8oA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:01:08 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:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:01:08 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-3Bbb_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:01:09 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:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:01:09 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-EPI1JY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:01:09 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:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:01:09 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-ZAloRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:01:09 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:01:09 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:01:09 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:01:09 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:01:09 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:01:09 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:01:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:11 INFO - Downloading blessings-1.6.tar.gz 01:01:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:01:11 INFO - Installing collected packages: blessings 01:01:11 INFO - Running setup.py install for blessings 01:01:11 INFO - Successfully installed blessings 01:01:11 INFO - Cleaning up... 01:01:11 INFO - Return code: 0 01:01:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:01:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:01:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:01:12 INFO - Reading from file tmpfile_stdout 01:01:12 INFO - Current package versions: 01:01:12 INFO - blessings == 1.6 01:01:12 INFO - blobuploader == 1.2.4 01:01:12 INFO - docopt == 0.6.1 01:01:12 INFO - manifestparser == 1.1 01:01:12 INFO - mozInstall == 1.12 01:01:12 INFO - mozcrash == 0.16 01:01:12 INFO - mozdebug == 0.1 01:01:12 INFO - mozdevice == 0.48 01:01:12 INFO - mozfile == 1.2 01:01:12 INFO - mozhttpd == 0.7 01:01:12 INFO - mozinfo == 0.9 01:01:12 INFO - mozleak == 0.1 01:01:12 INFO - mozlog == 3.1 01:01:12 INFO - moznetwork == 0.27 01:01:12 INFO - mozprocess == 0.22 01:01:12 INFO - mozprofile == 0.28 01:01:12 INFO - mozrunner == 6.11 01:01:12 INFO - mozscreenshot == 0.1 01:01:12 INFO - mozsystemmonitor == 0.0 01:01:12 INFO - moztest == 0.7 01:01:12 INFO - mozversion == 1.4 01:01:12 INFO - psutil == 3.1.1 01:01:12 INFO - requests == 1.2.3 01:01:12 INFO - wsgiref == 0.1.2 01:01:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:01: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:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:12 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 0x107c15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c1d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc439d8ad80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ab9d30>, '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 0x1078dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ab0b20>, '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.O7P4Den0YK/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.ePFzkPTsbe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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:01:12 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:01:12 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:01:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O7P4Den0YK/Render', 01:01:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:01:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:01:12 INFO - 'HOME': '/Users/cltbld', 01:01:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:01:12 INFO - 'LOGNAME': 'cltbld', 01:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:12 INFO - 'MOZ_NO_REMOTE': '1', 01:01:12 INFO - 'NO_EM_RESTART': '1', 01:01:12 INFO - 'PAGER': '/bin/cat', 01:01:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:12 INFO - 'PWD': '/builds/slave/test', 01:01:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:01:12 INFO - 'SHELL': '/bin/bash', 01:01:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ePFzkPTsbe/Listeners', 01:01:12 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 01:01:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:01:12 INFO - 'USER': 'cltbld', 01:01:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:01:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:12 INFO - 'XPC_FLAGS': '0x0', 01:01:12 INFO - 'XPC_SERVICE_NAME': '0', 01:01:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:12 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:01:12 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:01:12 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:01:12 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:01:12 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:01:12 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:01:12 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:01:12 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:01:12 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:01:12 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:01:12 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:01:12 INFO - Cleaning up... 01:01:12 INFO - Return code: 0 01:01:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:01: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:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:12 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 0x107c15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c1d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc439d8ad80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ab9d30>, '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 0x1078dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ab0b20>, '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.O7P4Den0YK/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.ePFzkPTsbe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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:01:12 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:01:12 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:01:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O7P4Den0YK/Render', 01:01:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:01:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:01:12 INFO - 'HOME': '/Users/cltbld', 01:01:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:01:12 INFO - 'LOGNAME': 'cltbld', 01:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:12 INFO - 'MOZ_NO_REMOTE': '1', 01:01:12 INFO - 'NO_EM_RESTART': '1', 01:01:12 INFO - 'PAGER': '/bin/cat', 01:01:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:12 INFO - 'PWD': '/builds/slave/test', 01:01:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:01:12 INFO - 'SHELL': '/bin/bash', 01:01:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ePFzkPTsbe/Listeners', 01:01:12 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 01:01:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:01:12 INFO - 'USER': 'cltbld', 01:01:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:01:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:12 INFO - 'XPC_FLAGS': '0x0', 01:01:12 INFO - 'XPC_SERVICE_NAME': '0', 01:01:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:12 INFO - Downloading/unpacking jsonschema 01:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:01:15 INFO - Downloading/unpacking functools32 (from jsonschema) 01:01:15 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:15 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:15 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:15 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:15 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:15 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:15 INFO - Downloading functools32-3.2.3-2.tar.gz 01:01:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:01:15 INFO - warning: no files found matching '*.txt' 01:01:15 INFO - no previously-included directories found matching 'build' 01:01:15 INFO - no previously-included directories found matching 'dist' 01:01:15 INFO - no previously-included directories found matching '.git*' 01:01:15 INFO - Installing collected packages: jsonschema, functools32 01:01:15 INFO - Running setup.py install for functools32 01:01:15 INFO - warning: no files found matching '*.txt' 01:01:15 INFO - no previously-included directories found matching 'build' 01:01:15 INFO - no previously-included directories found matching 'dist' 01:01:15 INFO - no previously-included directories found matching '.git*' 01:01:15 INFO - Successfully installed jsonschema functools32 01:01:15 INFO - Cleaning up... 01:01:15 INFO - Return code: 0 01:01:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:01:15 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:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:15 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:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:15 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 0x107c15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c1d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc439d8ad80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ab9d30>, '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 0x1078dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ab0b20>, '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.O7P4Den0YK/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.ePFzkPTsbe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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:01:15 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:01:15 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:01:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O7P4Den0YK/Render', 01:01:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:01:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:01:15 INFO - 'HOME': '/Users/cltbld', 01:01:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:01:15 INFO - 'LOGNAME': 'cltbld', 01:01:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:15 INFO - 'MOZ_NO_REMOTE': '1', 01:01:15 INFO - 'NO_EM_RESTART': '1', 01:01:15 INFO - 'PAGER': '/bin/cat', 01:01:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:01:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:15 INFO - 'PWD': '/builds/slave/test', 01:01:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:01:15 INFO - 'SHELL': '/bin/bash', 01:01:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ePFzkPTsbe/Listeners', 01:01:15 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 01:01:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:01:15 INFO - 'USER': 'cltbld', 01:01:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:01:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:01:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:15 INFO - 'XPC_FLAGS': '0x0', 01:01:15 INFO - 'XPC_SERVICE_NAME': '0', 01:01:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:16 INFO - Downloading/unpacking flake8 01:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:01:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:01:18 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:18 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:18 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:18 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:18 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:18 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:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:01:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:01:18 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:18 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:18 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:18 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:18 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:18 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:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:01:19 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:19 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:19 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:19 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:19 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:19 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:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:01:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:01:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:01:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:01:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:01:19 INFO - no previously-included directories found matching 'docs/_build' 01:01:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:01:19 INFO - Running setup.py install for pep8 01:01:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:01:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:01:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:01:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:01:20 INFO - no previously-included directories found matching 'docs/_build' 01:01:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:01:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:01:20 INFO - Cleaning up... 01:01:20 INFO - Return code: 0 01:01:20 INFO - Running post-action listener: _resource_record_post_action 01:01:20 INFO - Running post-action listener: _start_resource_monitoring 01:01:20 INFO - Starting resource monitoring. 01:01:20 INFO - ##### 01:01:20 INFO - ##### Running install step. 01:01:20 INFO - ##### 01:01:20 INFO - Running pre-action listener: _resource_record_pre_action 01:01:20 INFO - Running main action method: install 01:01:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:01:20 INFO - Reading from file tmpfile_stdout 01:01:20 INFO - Detecting whether we're running mozinstall >=1.0... 01:01:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:01:20 INFO - Reading from file tmpfile_stdout 01:01:20 INFO - Output received: 01:01:20 INFO - Usage: mozinstall [options] installer 01:01:20 INFO - Options: 01:01:20 INFO - -h, --help show this help message and exit 01:01:20 INFO - -d DEST, --destination=DEST 01:01:20 INFO - Directory to install application into. [default: 01:01:20 INFO - "/builds/slave/test"] 01:01:20 INFO - --app=APP Application being installed. [default: firefox] 01:01:20 INFO - mkdir: /builds/slave/test/build/application 01:01:20 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:20 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:54 INFO - Reading from file tmpfile_stdout 01:01:54 INFO - Output received: 01:01:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:01:54 INFO - Running post-action listener: _resource_record_post_action 01:01:54 INFO - ##### 01:01:54 INFO - ##### Running run-tests step. 01:01:54 INFO - ##### 01:01:54 INFO - Running pre-action listener: _resource_record_pre_action 01:01:54 INFO - Running main action method: run_tests 01:01:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:01:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:01:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:01:54 INFO - 2016-02-26 01:01:54.247 screenresolution[1651:8185] starting screenresolution argv=screenresolution get 01:01:54 INFO - 2016-02-26 01:01:54.250 screenresolution[1651:8185] Display 0: 1600x1200x32@60 01:01:54 INFO - 2016-02-26 01:01:54.255 screenresolution[1652:8187] starting screenresolution argv=screenresolution list 01:01:54 INFO - Available Modes on Display 0 01:01:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:01:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:01:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:01:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:01:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:01:54 INFO - Intel Iris: 01:01:54 INFO - Chipset Model: Intel Iris 01:01:54 INFO - Type: GPU 01:01:54 INFO - Bus: Built-In 01:01:54 INFO - VRAM (Dynamic, Max): 1536 MB 01:01:54 INFO - Vendor: Intel (0x8086) 01:01:54 INFO - Device ID: 0x0a2e 01:01:54 INFO - Revision ID: 0x0009 01:01:54 INFO - Displays: 01:01:54 INFO - Display: 01:01:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:01:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:01:54 INFO - Display Serial Number: 1600x1200 60 01:01:54 INFO - Main Display: Yes 01:01:54 INFO - Mirror: Off 01:01:54 INFO - Online: Yes 01:01:54 INFO - Rotation: Supported 01:01:54 INFO - Return code: 0 01:01:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:01:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:01:54 INFO - Python 2.7.3 01:01:54 INFO - Return code: 0 01:01:54 INFO - grabbing minidump binary from tooltool 01:01:54 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:54 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 0x107ab9d30>, '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 0x1078dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ab0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:01:54 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:54 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:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:01:54 INFO - Return code: 0 01:01:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:01:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:01:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:01:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:01:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:01:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:01:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:01:55 INFO - Return code: 0 01:01:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0077', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0077 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:01:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O7P4Den0YK/Render', 01:01:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:01:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:01:55 INFO - 'HOME': '/Users/cltbld', 01:01:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:01:55 INFO - 'LOGNAME': 'cltbld', 01:01:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:01:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:55 INFO - 'MOZ_NO_REMOTE': '1', 01:01:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:01:55 INFO - 'NO_EM_RESTART': '1', 01:01:55 INFO - 'PAGER': '/bin/cat', 01:01:55 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:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:55 INFO - 'PWD': '/builds/slave/test', 01:01:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:01:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:01:55 INFO - 'SHELL': '/bin/bash', 01:01:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ePFzkPTsbe/Listeners', 01:01:55 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 01:01:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:01:55 INFO - 'USER': 'cltbld', 01:01:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:01:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:55 INFO - 'XPC_FLAGS': '0x0', 01:01:55 INFO - 'XPC_SERVICE_NAME': '0', 01:01:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:01:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0077', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:01:56 INFO - mozversion application_buildid: 20160226000943 01:01:56 INFO - mozversion application_changeset: a97d22a2418febbac21e5f6117046a3d739d5c5a 01:01:56 INFO - mozversion application_display_name: Nightly 01:01:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:01:56 INFO - mozversion application_name: Firefox 01:01:56 INFO - mozversion application_remotingname: firefox 01:01:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:01:56 INFO - mozversion application_vendor: Mozilla 01:01:56 INFO - mozversion application_version: 47.0a1 01:01:56 INFO - mozversion platform_buildid: 20160226000943 01:01:56 INFO - mozversion platform_changeset: a97d22a2418febbac21e5f6117046a3d739d5c5a 01:01:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:01:56 INFO - mozversion platform_version: 47.0a1 01:01:56 INFO - using testdate: 1456477316 01:01:56 INFO - actual date: 1456477316 01:01:56 INFO - starting webserver on 'localhost:49274' 01:01:56 INFO - SUITE-START | Running 2 tests 01:01:56 INFO - TEST-START | dromaeo_css 01:01:56 INFO - operating with platform_type : mac_ 01:01:56 INFO - Initialising browser for dromaeo_css test... 01:01:56 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmpjptfv4/profile http://localhost:49274/getInfo.html) 01:01:58 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 01:01:58 INFO - PROCESS | 1670 | colorDepth:24 01:01:58 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 01:01:58 INFO - PROCESS | 1670 | __metrics 01:01:59 INFO - PROCESS | 1670 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:01:59 INFO - PROCESS | 1670 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:01:59 INFO - TEST-INFO | 1670: exit 0 01:01:59 INFO - Browser initialized. 01:01:59 INFO - Running cycle 1/1 for dromaeo_css test... 01:01:59 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmpjptfv4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:02:11 INFO - PROCESS | 1674 | RSS: Main: 244363264 01:02:11 INFO - PROCESS | 1674 | 01:03:02 INFO - PROCESS | 1674 | 1456477382465 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:05:12 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 01:05:13 INFO - PROCESS | 1674 | RSS: Main: 381698048 01:05:13 INFO - PROCESS | 1674 | 01:08:16 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 01:08:16 INFO - PROCESS | 1674 | RSS: Main: 380964864 01:08:16 INFO - PROCESS | 1674 | 01:11:18 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 01:11:19 INFO - PROCESS | 1674 | RSS: Main: 377257984 01:11:19 INFO - PROCESS | 1674 | 01:14:21 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 01:14:22 INFO - PROCESS | 1674 | RSS: Main: 339914752 01:14:22 INFO - PROCESS | 1674 | 01:17:25 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 01:17:25 INFO - PROCESS | 1674 | RSS: Main: 341442560 01:17:25 INFO - PROCESS | 1674 | 01:20:28 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 01:20:28 INFO - PROCESS | 1674 | RSS: Main: 383283200 01:20:28 INFO - PROCESS | 1674 | 01:20:28 INFO - PROCESS | 1674 | __start_tp_report 01:20:28 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 01:20:28 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 01:20:28 INFO - PROCESS | 1674 | |i|pagename|runs| 01:20:28 INFO - PROCESS | 1674 | |0;dojo.html;3336.499525071239;3340.2317466982595;3355.6141043779967;3355.983220083899;3411.829408529573;5436.673799572019;5506.4218257082985;5511.834644960652;5526.530244929186;5561.3882472928;5519;5544.3346798384255;5567.498925096751;5678.063119585274;5687.090065589507;4962.6774259673;4986.551210391064;4996.075725990685;5020.97489512552;5199.376074871002;5102.234664800272;5131.692098474085;5142.177251639739;5163.225516172567;5178.171492561191;4944.283078953532;4967.354243948282;5046.5710414614805;5057.595392368602;5079.907819818757;4975.875603109915;4983.750812459362;4987.526185012418;5010.348654674869;5012.04771093491;4907.705537667715;4932.654714170009;4935.432425271104;4978.079055374767;5001.349824522825;5369.543588794957;5448.509634132947;5502.5597952164135;5537.833864984057;5563.638363506399;6075.756969721206;6100.96949515254;6103.633781973052;6114.602550834226;6130.662813545253;6110.175126357974;6191.349908259658;6202.968985155046;6207.193064901534;6223.284322302948;5565.165225216209;5597.412271711493;5646.265985421869;5663.660180389149;5677.290338707661;6196.0705894115345;6204.224471941007;6209.379062093845;6250.9062364064575;6321.715522801485;5919.822405327847;5933.080372542263;5953.553483488756;5986.07215881539;5992.221011268507;6047.334793172748;6100.267967843887;6111.227117700271;6114.144019837227;6153.261608606996;6071.180390647294;6071.787487437919;6077.453029227391;6082.908756368658;6121.602095863755;6042.516598672096;6044.697765111727;6056.06131049688;6062.545309101747;6080.57435979486;4752.1921273383605;4778.856634300976;4799.784009719501;4800.159972004885;4838.903221935541;4319.244132276902;4335.241332766753;4366.541513141138;4369.694121411534;4373.693841431069;5560.610757247035;5593.300837395325;5605.635633683797;5622.803201887914;5625.634333768292;6102.489251635809;6112.381899552462;6125.571210015345;6203.503719702413;6238.781642642576;5664.122061080539;5676.063449530864;5682.516986056232;5684.744186511617;5694.060480020833;5286.259923610698;5300.602454815904;5306.495882891119;5316.149416093406;5340.626156169031;6102.156009074812;6142.099766648211;6174.351693072253;6204.968975155095;6217.0052791553135;6175.2589689237575;6201.193844800147;6202;6202.7829025985675;6209.379062093754;6149.446549810538;6216.502679785697;6238.532110091671;6243.406876346739;6255.40573645503;5998.1002849572915;6011.789587364421;6075.331713511422;6099.146119543356;6109.572329936862;6167.691615419121;6175.722092505758;6183.5671502994355;6192.59748116371;6204.286507051746;5766.106253530709;5922.496587789914;5958.612690175125;5986.880262394815;5993.9700301498215;5801.419858014165;5803.187553742395;5803.912941305968;5807.593468457168;5859.20900678403;5520.475554822286;5592.664440133605;5665.49010589049;5678.063119585222;5681.573881958787;5760.395158508296;5833.008388573868;5834.591578589458;5838.416158384128;5902.1146827976145;5842.5325973921135;5846.386129456346;5855.560832937632;5856.150858125633;5863.706814659336 01:20:28 INFO - PROCESS | 1674 | |1;ext.html;507.24673859318904;511.25101725971444;511.822807542652;543.6683622989976;626.764963138823;37289.62710372899;37819.621803781956;37866;37895;37914.810425947864;39774;40086.599134008655;40316.39525407121;40328.19343613133;40370.58702945398;9495.952520237406;9720;9720.513974301291;9727.07592778685;9742.951285243564;9651;9796.951015244913;9800.117989380955;9811.362261453018;9827.410355378664;9786.6085356586;9838;9850.162736167435;9869.210463162966;9873.555689993931;9737.951310243474;9828.4102953823;9833.754156146153;9840.507974601313;9853.556589953434;9584.520773961343;9712.660056898045;9722.222222222275;9723.756906077333;9743.756406089833;38400;38504.614953850665;38560.035999099964;38579.80710096432;38608.61391386107;3134.7492200623897;3174.8094464575784;3201.9679803202134;3213.052149615869;3228.951565726516;28042.439151217066;28121.29696757577;28144.43711125766;28270.15189544317;28763.849446022134;2738.7437631335197;2770.459760346733;2807.270109771454;2847.430513897229;2872.339361946743;457064;458150;458276.7086164581;458382;460059;44080.559194408284;61176;61995;62044.75910481856;62059;43120.92197695083;43193;43226.56773432288;43240;43278.13443731108;14607.415703371746;14888;14898.925505372405;14900.925495372454;14909;12063.638090857288;12096.879031209752;12116.878831211576;12130.878691212974;12134.575289864812;11344.943275283737;14010.929945350208;14314.570562883131;14345.856541434661;14468.927655361866;6094.603850749687;6159.784407545714;6207.255129384503;6213.37866213375;6214.844628884223;904.9773755656162;918.5407296351824;963.0898800633474;1013.4122209118693;1082.1883587309517;28709.425811483652;28760.568591471143;29173.41653166967;29321.973730919315;29469.705302946695;859.4542465534431;899.1458114790975;1047.188428967541;1080.0495563903871;1240.0079936051122;13968.860311396958;13969.511067112806;14070.301677313913;14221.85778142226;14229;528931;529807;535871;535975;536142;56773;57086.42913570811;57087.85824283491;57174;57215;1311.6065180445828;1424.6509605146598;1457.8323492798252;1459.3870574358796;1514.5380658899142;27908.30229244285;28237.055520898317;28656.856715716287;29271.414571708872;29673.703262967094;46512.53487465217;46758.298625521325;46820.531794681614;46856;46899.062018760116;353334;355415;355582;355924.4407555891;356187;27226.86386568134;30650.540241896837;32229.51655725213;32646.51030234596;32658.673413265562;39800;40337.39493907653;40387.19225615412;40623.39064913969;41462;33341.16647083842;34135.146621334665;34550.13624659403;34663.653363466045;34971.65028349786;33140;34768;35118.47322290219;35747.82126089457;35945.820270898475;35815.46276805902;35847.46228806518;36014.4597831038;36087.819560902026;37258.813705931294;30860.69139308668;31167;32239.516407253443;32241.51637725389;32340.353192935538;23933.521329573658;24496.14263500769;24525.632115517925;24806.875965620056;24888 01:20:28 INFO - PROCESS | 1674 | |2;jquery.html;318.8820136549477;358.31025276343036;362.586651217612;363.316964107478;371.9572249191342;19229.51926201844;19321.903390483047;20224.49438764028;20238.89880550599;20271.49321266969;19068.809311906876;19145.61708765824;19818.504537386572;19880.701789473133;19895.104720287585;5077.949220507785;5675.5459563235045;5865.648061116325;5909.586328956974;5928.5849990500465;4179.435776170224;4351;4371;4375.781210939456;5761.625494342875;6392.296847346788;6399.36006399361;6406.903896441557;6414.903776443357;6421.678916054202;6175.258968923713;6218.160548325964;6286.088517165032;6310.33741457145;6316.873662526724;3321.70104690579;3699.8520059197867;5388.7305634718105;5410.431904650034;5414.35027796663;19953.501162470908;24443.755562444327;24695.87652061746;24704.876475617508;25458.72706364693;2077.885716285604;2136.465883529118;2286.8056215221727;2524.734902835213;2870.6985766494427;11697.649070527897;13943.372548235353;13949.302534873215;14291.428342866377;14393.136411815325;1699.8441060079142;1704.565335839353;1757.635979607426;1903.7049257365131;1909.484439201408;108288;109969.80060398827;111181.88818111796;111476.44261778721;111525;11260.310953356899;11300.26548274376;11311.60409385684;11329.660110196708;11466.94266528662;13596.728065438636;13655.975801814704;13666.453341866412;13674.863251367558;13696.383662735201;8347.874781878276;8493.405461617627;8506.31949444043;8589.527575983257;8612.956935215409;8590.312774977987;8600.956995215109;8617.784555386166;8694.087120852346;8698.869516957251;4097.364908439196;4376.846810361622;4448.043670610769;4464.709793863389;4520.141173177086;1560.66445714172;1735.826417358254;1806.6964620109466;1813.3290682447316;1863.4689113602828;831.8170002599419;846.724814435311;909.3770767024477;959.3716115944068;1037.906588407047;19596.216151353787;20119.597608047756;20181.596368072558;20274.290399835936;20416;918.6004088221645;962.0379620379621;964.4020707161604;985.6500942165571;1055.1137044882337;8057.949294367429;10438.060574548326;10657.626983055556;10736.206990810422;10800.837987430195;523504;532456;532865;588029;617192;108375.45812270888;110571;113176.43411782889;118631.81368186207;120414.19378709326;912.3750231091724;938.6480069973624;1012.1245122968579;1027.7225149209821;1047.2407504559285;15947.840521594635;17953.461396158134;17963.101844907964;17979.550511237325;18043.729344060113;49178;50046.49860504191;50132.74933625309;50822.237666434296;54472.18291725548;68342.65828670825;68776.6561167191;71204.64397677979;75388;75421;7775.183605721318;7789.260020298063;7991.2807847294025;8049.315808156372;8270.917290827014;9349.813003740022;12784.296863672587;12817.295048772034;13191.472341106248;13299.601011969657;7249.746258880914;11362.772744545227;11420.31478111316;11482.425878706199;11507.309561426342;11360.829587556358;11494;11505.48225329879;11545.191836571359;11646.475908583965;11779.705507362385;11834.526618935146;11861.466234019317;11977.940110299392;12012.339321337411;8022.638981245741;8042.718504852302;8148.144444833207;8180.5909704515725;8217.506949583045;10570.41862697559;11604.187706860439;11857.407129643656;11900.76198476043;11940.582079627171 01:20:28 INFO - PROCESS | 1674 | |3;mootools.html;1392.4917405147125;1510.2901636230972;1518.6051626577093;1766.8586513078956;1950.4148755373394;8011.879821802678;8595.74212773617;8749.781255468617;8751.956240218806;8760.992485864128;7835.80410489738;8086.71696490623;8668.739937801876;8679.47923124613;8687;2172.8479006469474;2414.8913298901502;2452.2030340139436;2476.2818782553036;2477.950440991179;2488.9875550622314;2491.4643351679383;2495.0019992003163;2495.4884248728968;2502.774750272475;2369.218158007853;2453.914113006045;2471.826972111944;2472.196536125757;2472.950540989179;2433.5376278507115;2457.078595526669;2465.9753402465926;2478.7397323280975;2478.95042099157;2445.9143929962543;2460.2496238647204;2468.9506209875703;2471.0486462711806;2476.0343466048257;8828.293736501064;8903.065178156265;8909.599068041955;8921.375503714742;8921.509316987564;5406.864828379322;5558.360788509332;5603.5237004854225;5619.943800561983;5623.634463759842;3193.2016995751064;3559.0924314299946;3681.9815900920325;3719.9070023249365;3747.7938713370754;1058.444316733721;1073.0771536478621;1080.6974047266779;1088.298047759191;1090.0679918669503;12130.090243231793;12170.513179472811;12186.878131218664;12247.265164090182;12247.69380765479;4909.828156014594;4952.034353301072;5018.749062546858;5022.522860328263;5049.31834202378;10247.590096396061;10257.538410771533;10258.384496930208;10274.126699230648;10282.07461328484;5512.751926163332;5560.277163968658;5560.36055853582;5580.581456390706;5582.888342233133;4431.778411079433;4594.747288899142;4742.19382704941;4906.288588154697;4907.460179380265;3751.7936513491472;3834.482344883461;3857.3442514772555;3861.2084522672785;3873.806309684561;1310.8033794930836;1311.7442098790834;1319.7162610038695;1323.7881938889732;1327.3628658244097;1051.6897515233024;1065.4938904020528;1068.0280944340614;1263.8041103628952;1374.8418931822969;8128.471649342774;8189.22202390772;8199.549024803573;8215.712450064339;8408.32733381328;1179.9823002654966;1181.645506348092;1184.3190165654783;1192.2310109979014;1199.6101267088056;6302.968485157637;6349.809505714836;6352.968235158887;6359.968200159062;6361.332060133712;9018.639254429749;10333.638322658671;10561.735956600993;10718.624848130277;10743.979321964402;10316;10461.738456538495;10532.15742740579;10588.205884558689;10620.946895265473;8092.595370231465;8257.298129659046;8311.210435008665;8324.25081742646;8337.291330236876;8043.1554686757045;8044.27601515843;8097.87853182191;8165.469244499089;8274.544900030556;9471.715848524555;9705.417674939526;9798.85301720489;9820.656277030555;9936.801263974825;9942.15491683215;10133.44266065344;10251.538680759533;10269.332493387907;10361.585536578452;6874.346937040973;7270.527415717961;7468.850622987618;7560.130584982578;7701.998740163743;8242;8283.83432331362;8307.501549907025;8313.043999940084;8356.58217089131;6007.609505382136;7344.632768361454;7374.96750454926;7427.1087469501845;7527;7261.019762332017;7331.74338898136;7337.491873973374;7358.484906056525;7370.115586129698;7676.155622881367;7788;7790.727324543614;7795.986521752136;7798.454108212371;5966.8209953699725;7005.439564834903;7082.150141982995;7084.291570843081;7090;7096.822579435556;7179.317964793337;7192.244814294633;7200.747973820891;7200.927990720026 01:20:28 INFO - PROCESS | 1674 | |4;prototype.html;318.2759222768202;320.5256220793226;326.53957919333743;331.5093661381155;334.333005653721;5803.854903627406;6433.742650293994;6450.870982580345;6566.277709451956;6589.439897608697;6435.935640643592;6436.452901503378;6443.935560644392;6464.288928217892;6478.190226221723;4578.10726908253;4763.14263432582;4766.594839438651;4769.117713223048;4824.734639594821;4672.532746725335;4748;4787.688800227974;4789.204048481819;4813.711177329372;4768.880777980544;4777.498362671921;4786.234202527597;4800;4817.494163112875;4762.809487620491;4783.736894470802;4786.617070634341;4789.4971028042255;4806.975965120169;3415.334009868077;3904.863329783444;3960.0693836948294;3972.980135099335;3992.7803970781597;6230.2523697156175;6231.470325022378;6245.437910588023;6249.375062493714;6255.186825712628;5617.21359009739;5656.444477768606;5659.122835960433;5664.320281566238;5673.177389278531;6947.027416161742;6977.511574189809;6979.336962988508;6981.232064472904;6983.092198014277;4588.931166032512;4598.057398233354;4600.815967361302;4603.447586289633;4604.171249175147;7082.36258736711;7297.306755858185;7416;7420.443466740016;7433.773427384475;4532.79602417892;4596.954030459653;4604.608608268335;4605.332226827159;4605.355250264965;4662.393888794435;4663.720176789336;4664.836730714409;4666.556677115668;4670.789814458358;5551;5559.694216818114;5561.110222364402;5562.610617256753;5567.693776842312;6713.597184168965;7044.22513523512;7055.8236044098285;7062.929370706227;7064.576125432491;1591.681663667271;1598.5284341119398;1610.4604957339423;1612.5243053299305;1613.6853313603735;1025.8820235672845;1026.225199974015;1040.78143589847;1041.8437234414898;1044.498640652491;6439.420452159235;6556.475481961432;6565.967170164214;6590.835229119214;6604.3725846044545;6987.541167122307;7146.821329466701;7246.166690830517;7331.303526165006;7403.407727381797;6631.602103873783;6646.401823835878;6648.767293144717;6658.700358483879;6674.899876501856;3828.770273783582;3865.4974853268895;3870.7871067091583;3875.2636998970106;3875.9031024224055;7682.116556595951;7691.1924247954275;7692.76921692339;7694.807629809299;7695;7228.602426866572;7471.589062601501;7478.027856378636;7478.177400485943;7480.8877866832045;7449.366803821736;7500.699972001168;7501.962490187514;7515.624218789038;7522.849543009219;5948.226730525004;7289.890651640336;7317.853642927218;7320.194778574459;7322.487425880137;6933.583984960918;7212.954121652226;7213.639318034182;7214.567125972459;7214.603196824225;7602.885956710765;7673.923260767321;7711.498752581064;7721.53670779755;7730.420218483524;4604.6086082682;4656.906861862676;4658.86023419298;4661.766911654471;4665.440147182224;7317.085364329459;7328.3404493595835;7329;7331;7336.119665640157;6767.830804229934;7039.753608623673;7074.327938845801;7075.028488035141;7075.752348667772;6986.336298051677;7017.929820701932;7019.29807019294;7037.753678621224;7042.507024508235;6834.350736680008;6836.692348844214;6841.62371069596;6845.726170953106;6849.623270719959;7035;7040.894386584103;7042.577445353295;7048.400885924549;7055.153381594037;6615.776081424951;6815.352541508549;6872.828179295558;6878.243393226641;6886.380225779503 01:20:28 INFO - PROCESS | 1674 | |5;yui.html;616.0143769968055;690.2683155854794;697.8674051930129;736.5249414127887;760.471472326733;14628.853711462882;14984;14987.400503979841;14993.925030374832;15033.173175475344;13607.319634018284;13659.590212293622;13693.589192324222;13702.657433564165;13705.3832577534;670.3865962644174;687.7695971849437;843.2031730015138;845.4842546046922;855.9144085591422;844.273924424994;856.1737922904396;858.0304256190527;859.7334826203897;863.2144748279068;893.0845882969975;898.4968417686084;898.6989358564889;898.874157617934;899.1368286445021;716.9354758071772;888.4536010353619;892.1435421994893;894.8120894612139;899.554720413393;667.079430386069;671.1275342055309;672.8586996730693;672.9293424190488;676.5940435738567;14638.194899280536;14640.853591464056;14649.560513184515;14657.780133298009;14708.48520301795;12277.69305767363;12290.75418491634;12317.630471085882;12579.245245285312;12706.983441324672;10069.54687039085;10112.797744045078;10114.898851011469;10143.391396516232;10156.136728378096;3482.320947415255;3519.7360197985254;3545.663161999606;3562.6793588576893;3740.5511338639267;76375.61812190959;77979.22020779776;78304.21695783026;78314.60842695751;78716;9130.25505147354;9191.126842949909;9281.164695177466;9440.716778496519;9735.513224338754;20086.49783755418;20336.491587710425;20347.69478457824;20352.49118772013;20417;7284.854302914018;7336.449766267551;7394.963025184948;7421.443705052059;7547.73582924595;3956.149427873021;4045.4336392905016;4083.7958102094776;4102.384642303678;4198.6221240088535;3615.4215325547784;3616.2044350242904;3655.2689462107683;3655.5796083450214;3659.8902032939054;606.5147881694627;671.3655595462242;673.0778832998725;683.2757277286092;689.1076056506836;532.8348212054198;535.9678419294855;553.3885057012025;573.4466240078344;623.4108767215029;8025.357971362277;8195.180481951757;8235.052968908532;8249;8314.875276870851;586.1881294407276;595.791472984452;596.5436441122545;605.7365046204915;605.9333473317931;3700.5559332880225;3893.240818040455;3938.15329704115;3947.151362457028;3948.368261078214;91686;93671;93751.0624893756;94061.11877762407;94198.5290073559;78388.82416763753;78737;78961;79230;79831.60084199542;69319.96020059704;69658.9551156733;70350.64824675844;70638;71288;7722.034745656793;7750.92249077502;7934.325582325567;8009.872447577492;8052.114267430695;35284.294314114086;46170.307445387676;47286.76356618195;48786.756066219445;49685;63468.682656586425;67242.31894202488;68307.65846170936;69000.6549967247;69460;9925.255605829447;9978.550965206437;10049.69850904474;10633.255672103189;10905.291156074829;12035.097367697283;12263.325517096646;12387.19483233623;12399.380030998595;12724.236545807282;11526.995037786066;11562.537498499965;11584;11794.705132371759;11887.583934562248;11625.767484650429;11670.649880503599;11770.882291176978;11983.101267404805;11992.280463172237;9905.900940990787;11388.715282118013;11620.88379116198;11737.765244695229;12264.811149101119;7832.37341012729;9564.95217523908;9787.510624468605;9806.656767013406;10119.190464762949;9086.863697044682;9731.318807683394;9754.756131096496;9764.707058788248;9767.951160244438 01:20:28 INFO - PROCESS | 1674 | __end_tp_report 01:20:28 INFO - PROCESS | 1674 | __start_cc_report 01:20:28 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1211 01:20:28 INFO - PROCESS | 1674 | __end_cc_report 01:20:28 INFO - PROCESS | 1674 | __startTimestamp1456478428808__endTimestamp 01:20:28 INFO - PROCESS | 1674 | 01:20:28 INFO - PROCESS | 1674 | ------- Summary: start ------- 01:20:28 INFO - PROCESS | 1674 | Number of tests: 6 01:20:28 INFO - PROCESS | 1674 | 01:20:28 INFO - PROCESS | 1674 | [#0] dojo.html Cycles:165 Average:5613.23 Median:5801.42 stddev:631.34 (10.9%) stddev-sans-first:607.48 01:20:28 INFO - PROCESS | 1674 | Values: 3336.5 3340.2 3355.6 3356.0 3411.8 5436.7 5506.4 5511.8 5526.5 5561.4 5519.0 5544.3 5567.5 5678.1 5687.1 4962.7 4986.6 4996.1 5021.0 5199.4 5102.2 5131.7 5142.2 5163.2 5178.2 4944.3 4967.4 5046.6 5057.6 5079.9 4975.9 4983.8 4987.5 5010.3 5012.0 4907.7 4932.7 4935.4 4978.1 5001.3 5369.5 5448.5 5502.6 5537.8 5563.6 6075.8 6101.0 6103.6 6114.6 6130.7 6110.2 6191.3 6203.0 6207.2 6223.3 5565.2 5597.4 5646.3 5663.7 5677.3 6196.1 6204.2 6209.4 6250.9 6321.7 5919.8 5933.1 5953.6 5986.1 5992.2 6047.3 6100.3 6111.2 6114.1 6153.3 6071.2 6071.8 6077.5 6082.9 6121.6 6042.5 6044.7 6056.1 6062.5 6080.6 4752.2 4778.9 4799.8 4800.2 4838.9 4319.2 4335.2 4366.5 4369.7 4373.7 5560.6 5593.3 5605.6 5622.8 5625.6 6102.5 6112.4 6125.6 6203.5 6238.8 5664.1 5676.1 5682.5 5684.7 5694.1 5286.3 5300.6 5306.5 5316.1 5340.6 6102.2 6142.1 6174.4 6205.0 6217.0 6175.3 6201.2 6202.0 6202.8 6209.4 6149.4 6216.5 6238.5 6243.4 6255.4 5998.1 6011.8 6075.3 6099.1 6109.6 6167.7 6175.7 6183.6 6192.6 6204.3 5766.1 5922.5 5958.6 5986.9 5994.0 5801.4 5803.2 5803.9 5807.6 5859.2 5520.5 5592.7 5665.5 5678.1 5681.6 5760.4 5833.0 5834.6 5838.4 5902.1 5842.5 5846.4 5855.6 5856.2 5863.7 01:20:28 INFO - PROCESS | 1674 | 01:20:28 INFO - PROCESS | 1674 | [#1] ext.html Cycles:180 Average:58555.57 Median:37554.62 stddev:121025.02 (322.3%) stddev-sans-first:121286.05 01:20:28 INFO - PROCESS | 1674 | Values: 507.2 511.3 511.8 543.7 626.8 37289.6 37819.6 37866.0 37895.0 37914.8 39774.0 40086.6 40316.4 40328.2 40370.6 9496.0 9720.0 9720.5 9727.1 9743.0 9651.0 9797.0 9800.1 9811.4 9827.4 9786.6 9838.0 9850.2 9869.2 9873.6 9738.0 9828.4 9833.8 9840.5 9853.6 9584.5 9712.7 9722.2 9723.8 9743.8 38400.0 38504.6 38560.0 38579.8 38608.6 3134.7 3174.8 3202.0 3213.1 3229.0 28042.4 28121.3 28144.4 28270.2 28763.8 2738.7 2770.5 2807.3 2847.4 2872.3 457064.0 458150.0 458276.7 458382.0 460059.0 44080.6 61176.0 61995.0 62044.8 62059.0 43120.9 43193.0 43226.6 43240.0 43278.1 14607.4 14888.0 14898.9 14900.9 14909.0 12063.6 12096.9 12116.9 12130.9 12134.6 11344.9 14010.9 14314.6 14345.9 14468.9 6094.6 6159.8 6207.3 6213.4 6214.8 905.0 918.5 963.1 1013.4 1082.2 28709.4 28760.6 29173.4 29322.0 29469.7 859.5 899.1 1047.2 1080.0 1240.0 13968.9 13969.5 14070.3 14221.9 14229.0 528931.0 529807.0 535871.0 535975.0 536142.0 56773.0 57086.4 57087.9 57174.0 57215.0 1311.6 1424.7 1457.8 1459.4 1514.5 27908.3 28237.1 28656.9 29271.4 29673.7 46512.5 46758.3 46820.5 46856.0 46899.1 353334.0 355415.0 355582.0 355924.4 356187.0 27226.9 30650.5 32229.5 32646.5 32658.7 39800.0 40337.4 40387.2 40623.4 41462.0 33341.2 34135.1 34550.1 34663.7 34971.7 33140.0 34768.0 35118.5 35747.8 35945.8 35815.5 35847.5 36014.5 36087.8 37258.8 30860.7 31167.0 32239.5 32241.5 32340.4 23933.5 24496.1 24525.6 24806.9 24888.0 01:20:28 INFO - PROCESS | 1674 | 01:20:28 INFO - PROCESS | 1674 | [#2] jquery.html Cycles:180 Average:33008.92 Median:13365.28 stddev:93246.65 (697.7%) stddev-sans-first:93475.92 01:20:28 INFO - PROCESS | 1674 | Values: 318.9 358.3 362.6 363.3 372.0 19229.5 19321.9 20224.5 20238.9 20271.5 19068.8 19145.6 19818.5 19880.7 19895.1 5077.9 5675.5 5865.6 5909.6 5928.6 4179.4 4351.0 4371.0 4375.8 5761.6 6392.3 6399.4 6406.9 6414.9 6421.7 6175.3 6218.2 6286.1 6310.3 6316.9 3321.7 3699.9 5388.7 5410.4 5414.4 19953.5 24443.8 24695.9 24704.9 25458.7 2077.9 2136.5 2286.8 2524.7 2870.7 11697.6 13943.4 13949.3 14291.4 14393.1 1699.8 1704.6 1757.6 1903.7 1909.5 108288.0 109969.8 111181.9 111476.4 111525.0 11260.3 11300.3 11311.6 11329.7 11466.9 13596.7 13656.0 13666.5 13674.9 13696.4 8347.9 8493.4 8506.3 8589.5 8613.0 8590.3 8601.0 8617.8 8694.1 8698.9 4097.4 4376.8 4448.0 4464.7 4520.1 1560.7 1735.8 1806.7 1813.3 1863.5 831.8 846.7 909.4 959.4 1037.9 19596.2 20119.6 20181.6 20274.3 20416.0 918.6 962.0 964.4 985.7 1055.1 8057.9 10438.1 10657.6 10736.2 10800.8 523504.0 532456.0 532865.0 588029.0 617192.0 108375.5 110571.0 113176.4 118631.8 120414.2 912.4 938.6 1012.1 1027.7 1047.2 15947.8 17953.5 17963.1 17979.6 18043.7 49178.0 50046.5 50132.7 50822.2 54472.2 68342.7 68776.7 71204.6 75388.0 75421.0 7775.2 7789.3 7991.3 8049.3 8270.9 9349.8 12784.3 12817.3 13191.5 13299.6 7249.7 11362.8 11420.3 11482.4 11507.3 11360.8 11494.0 11505.5 11545.2 11646.5 11779.7 11834.5 11861.5 11977.9 12012.3 8022.6 8042.7 8148.1 8180.6 8217.5 10570.4 11604.2 11857.4 11900.8 11940.6 01:20:28 INFO - PROCESS | 1674 | 01:20:28 INFO - PROCESS | 1674 | [#3] mootools.html Cycles:180 Average:6078.55 Median:5020.64 stddev:3202.72 (63.8%) stddev-sans-first:3192.33 01:20:28 INFO - PROCESS | 1674 | Values: 1392.5 1510.3 1518.6 1766.9 1950.4 8011.9 8595.7 8749.8 8752.0 8761.0 7835.8 8086.7 8668.7 8679.5 8687.0 2172.8 2414.9 2452.2 2476.3 2478.0 2489.0 2491.5 2495.0 2495.5 2502.8 2369.2 2453.9 2471.8 2472.2 2473.0 2433.5 2457.1 2466.0 2478.7 2479.0 2445.9 2460.2 2469.0 2471.0 2476.0 8828.3 8903.1 8909.6 8921.4 8921.5 5406.9 5558.4 5603.5 5619.9 5623.6 3193.2 3559.1 3682.0 3719.9 3747.8 1058.4 1073.1 1080.7 1088.3 1090.1 12130.1 12170.5 12186.9 12247.3 12247.7 4909.8 4952.0 5018.7 5022.5 5049.3 10247.6 10257.5 10258.4 10274.1 10282.1 5512.8 5560.3 5560.4 5580.6 5582.9 4431.8 4594.7 4742.2 4906.3 4907.5 3751.8 3834.5 3857.3 3861.2 3873.8 1310.8 1311.7 1319.7 1323.8 1327.4 1051.7 1065.5 1068.0 1263.8 1374.8 8128.5 8189.2 8199.5 8215.7 8408.3 1180.0 1181.6 1184.3 1192.2 1199.6 6303.0 6349.8 6353.0 6360.0 6361.3 9018.6 10333.6 10561.7 10718.6 10744.0 10316.0 10461.7 10532.2 10588.2 10620.9 8092.6 8257.3 8311.2 8324.3 8337.3 8043.2 8044.3 8097.9 8165.5 8274.5 9471.7 9705.4 9798.9 9820.7 9936.8 9942.2 10133.4 10251.5 10269.3 10361.6 6874.3 7270.5 7468.9 7560.1 7702.0 8242.0 8283.8 8307.5 8313.0 8356.6 6007.6 7344.6 7375.0 7427.1 7527.0 7261.0 7331.7 7337.5 7358.5 7370.1 7676.2 7788.0 7790.7 7796.0 7798.5 5966.8 7005.4 7082.2 7084.3 7090.0 7096.8 7179.3 7192.2 7200.7 7200.9 01:20:28 INFO - PROCESS | 1674 | 01:20:28 INFO - PROCESS | 1674 | [#4] prototype.html Cycles:180 Average:5744.87 Median:6561.22 stddev:1849.72 (28.2%) stddev-sans-first:1809.51 01:20:28 INFO - PROCESS | 1674 | Values: 318.3 320.5 326.5 331.5 334.3 5803.9 6433.7 6450.9 6566.3 6589.4 6435.9 6436.5 6443.9 6464.3 6478.2 4578.1 4763.1 4766.6 4769.1 4824.7 4672.5 4748.0 4787.7 4789.2 4813.7 4768.9 4777.5 4786.2 4800.0 4817.5 4762.8 4783.7 4786.6 4789.5 4807.0 3415.3 3904.9 3960.1 3973.0 3992.8 6230.3 6231.5 6245.4 6249.4 6255.2 5617.2 5656.4 5659.1 5664.3 5673.2 6947.0 6977.5 6979.3 6981.2 6983.1 4588.9 4598.1 4600.8 4603.4 4604.2 7082.4 7297.3 7416.0 7420.4 7433.8 4532.8 4597.0 4604.6 4605.3 4605.4 4662.4 4663.7 4664.8 4666.6 4670.8 5551.0 5559.7 5561.1 5562.6 5567.7 6713.6 7044.2 7055.8 7062.9 7064.6 1591.7 1598.5 1610.5 1612.5 1613.7 1025.9 1026.2 1040.8 1041.8 1044.5 6439.4 6556.5 6566.0 6590.8 6604.4 6987.5 7146.8 7246.2 7331.3 7403.4 6631.6 6646.4 6648.8 6658.7 6674.9 3828.8 3865.5 3870.8 3875.3 3875.9 7682.1 7691.2 7692.8 7694.8 7695.0 7228.6 7471.6 7478.0 7478.2 7480.9 7449.4 7500.7 7502.0 7515.6 7522.8 5948.2 7289.9 7317.9 7320.2 7322.5 6933.6 7213.0 7213.6 7214.6 7214.6 7602.9 7673.9 7711.5 7721.5 7730.4 4604.6 4656.9 4658.9 4661.8 4665.4 7317.1 7328.3 7329.0 7331.0 7336.1 6767.8 7039.8 7074.3 7075.0 7075.8 6986.3 7017.9 7019.3 7037.8 7042.5 6834.4 6836.7 6841.6 6845.7 6849.6 7035.0 7040.9 7042.6 7048.4 7055.2 6615.8 6815.4 6872.8 6878.2 6886.4 01:20:28 INFO - PROCESS | 1674 | 01:20:28 INFO - PROCESS | 1674 | [#5] yui.html Cycles:180 Average:18081.48 Median:32067.88 stddev:25540.73 (79.6%) stddev-sans-first:25578.71 01:20:28 INFO - PROCESS | 1674 | Values: 616.0 690.3 697.9 736.5 760.5 14628.9 14984.0 14987.4 14993.9 15033.2 13607.3 13659.6 13693.6 13702.7 13705.4 670.4 687.8 843.2 845.5 855.9 844.3 856.2 858.0 859.7 863.2 893.1 898.5 898.7 898.9 899.1 716.9 888.5 892.1 894.8 899.6 667.1 671.1 672.9 672.9 676.6 14638.2 14640.9 14649.6 14657.8 14708.5 12277.7 12290.8 12317.6 12579.2 12707.0 10069.5 10112.8 10114.9 10143.4 10156.1 3482.3 3519.7 3545.7 3562.7 3740.6 76375.6 77979.2 78304.2 78314.6 78716.0 9130.3 9191.1 9281.2 9440.7 9735.5 20086.5 20336.5 20347.7 20352.5 20417.0 7284.9 7336.4 7395.0 7421.4 7547.7 3956.1 4045.4 4083.8 4102.4 4198.6 3615.4 3616.2 3655.3 3655.6 3659.9 606.5 671.4 673.1 683.3 689.1 532.8 536.0 553.4 573.4 623.4 8025.4 8195.2 8235.1 8249.0 8314.9 586.2 595.8 596.5 605.7 605.9 3700.6 3893.2 3938.2 3947.2 3948.4 91686.0 93671.0 93751.1 94061.1 94198.5 78388.8 78737.0 78961.0 79230.0 79831.6 69320.0 69659.0 70350.6 70638.0 71288.0 7722.0 7750.9 7934.3 8009.9 8052.1 35284.3 46170.3 47286.8 48786.8 49685.0 63468.7 67242.3 68307.7 69000.7 69460.0 9925.3 9978.6 10049.7 10633.3 10905.3 12035.1 12263.3 12387.2 12399.4 12724.2 11527.0 11562.5 11584.0 11794.7 11887.6 11625.8 11670.6 11770.9 11983.1 11992.3 9905.9 11388.7 11620.9 11737.8 12264.8 7832.4 9565.0 9787.5 9806.7 10119.2 9086.9 9731.3 9754.8 9764.7 9768.0 01:20:28 INFO - PROCESS | 1674 | -------- Summary: end -------- 01:20:28 INFO - PROCESS | 1674 | 01:20:29 INFO - TEST-INFO | 1674: exit 0 01:20:29 INFO - TEST-OK | dromaeo_css | took 1112770ms 01:20:29 INFO - TEST-START | kraken 01:20:29 INFO - operating with platform_type : mac_ 01:20:29 INFO - Initialising browser for kraken test... 01:20:29 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmpm6IDe6/profile http://localhost:49274/getInfo.html) 01:20:31 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 01:20:31 INFO - PROCESS | 1680 | colorDepth:24 01:20:31 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 01:20:31 INFO - PROCESS | 1680 | __metrics 01:20:31 INFO - PROCESS | 1680 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:20:31 INFO - PROCESS | 1680 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:20:32 INFO - TEST-INFO | 1680: exit 0 01:20:32 INFO - Browser initialized. 01:20:32 INFO - Running cycle 1/1 for kraken test... 01:20:32 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmpm6IDe6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:20:43 INFO - PROCESS | 1682 | RSS: Main: 242925568 01:20:43 INFO - PROCESS | 1682 | 01:20:46 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 01:20:47 INFO - PROCESS | 1682 | RSS: Main: 289464320 01:20:47 INFO - PROCESS | 1682 | 01:20:49 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 01:20:50 INFO - PROCESS | 1682 | RSS: Main: 299745280 01:20:50 INFO - PROCESS | 1682 | 01:20:53 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 01:20:54 INFO - PROCESS | 1682 | RSS: Main: 286777344 01:20:54 INFO - PROCESS | 1682 | 01:20:56 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 01:20:56 INFO - PROCESS | 1682 | RSS: Main: 289533952 01:20:56 INFO - PROCESS | 1682 | 01:20:58 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:20:59 INFO - PROCESS | 1682 | RSS: Main: 289026048 01:20:59 INFO - PROCESS | 1682 | 01:21:02 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 01:21:02 INFO - PROCESS | 1682 | RSS: Main: 291487744 01:21:02 INFO - PROCESS | 1682 | 01:21:05 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 01:21:06 INFO - PROCESS | 1682 | RSS: Main: 290897920 01:21:06 INFO - PROCESS | 1682 | 01:21:08 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 01:21:09 INFO - PROCESS | 1682 | RSS: Main: 291516416 01:21:09 INFO - PROCESS | 1682 | 01:21:10 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:21:11 INFO - PROCESS | 1682 | RSS: Main: 325476352 01:21:11 INFO - PROCESS | 1682 | 01:21:13 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:21:13 INFO - PROCESS | 1682 | RSS: Main: 322736128 01:21:13 INFO - PROCESS | 1682 | 01:21:16 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:21:16 INFO - PROCESS | 1682 | RSS: Main: 331599872 01:21:16 INFO - PROCESS | 1682 | 01:21:19 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:21:19 INFO - PROCESS | 1682 | RSS: Main: 334635008 01:21:19 INFO - PROCESS | 1682 | 01:21:22 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:21:22 INFO - PROCESS | 1682 | RSS: Main: 334000128 01:21:22 INFO - PROCESS | 1682 | 01:21:24 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 01:21:24 INFO - PROCESS | 1682 | RSS: Main: 394612736 01:21:24 INFO - PROCESS | 1682 | 01:21:24 INFO - PROCESS | 1682 | __start_tp_report 01:21:24 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 01:21:24 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 01:21:24 INFO - PROCESS | 1682 | |i|pagename|runs| 01:21:24 INFO - PROCESS | 1682 | |0;ai-astar;111;109;150;163;123;113;114;112;110;112 01:21:24 INFO - PROCESS | 1682 | |1;audio-beat-detection;158;120;143;157;119;141;140;120;192;135 01:21:24 INFO - PROCESS | 1682 | |2;audio-dft;185;185;186;184;184;186;185;185;174;181 01:21:24 INFO - PROCESS | 1682 | |3;audio-fft;75;78;86;77;56;58;57;86;75;57 01:21:24 INFO - PROCESS | 1682 | |4;audio-oscillator;89;92;127;80;80;84;114;77;76;115 01:21:24 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;84;90;83;90;84;90;84;89;83;90 01:21:24 INFO - PROCESS | 1682 | |6;imaging-darkroom;93;94;104;150;124;94;92;93;93;93 01:21:24 INFO - PROCESS | 1682 | |7;imaging-desaturate;86;84;90;85;86;85;86;88;86;86 01:21:24 INFO - PROCESS | 1682 | |8;json-parse-financial;55;56;56;54;53;54;55;65;54;52 01:21:24 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;63;66;69;77;71;66;67;68;69;69 01:21:24 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;83;83;83;84;83;80;80;83;84;84 01:21:24 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;123;126;126;124;143;107;130;128;126;130 01:21:24 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;139;112;139;163;177;134;138;134;137;137 01:21:24 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;65;68;66;66;67;66;66;66;67;65 01:21:24 INFO - PROCESS | 1682 | __end_tp_report 01:21:24 INFO - PROCESS | 1682 | __start_cc_report 01:21:24 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,1179 01:21:24 INFO - PROCESS | 1682 | __end_cc_report 01:21:24 INFO - PROCESS | 1682 | __startTimestamp1456478484873__endTimestamp 01:21:24 INFO - PROCESS | 1682 | 01:21:24 INFO - PROCESS | 1682 | ------- Summary: start ------- 01:21:24 INFO - PROCESS | 1682 | Number of tests: 14 01:21:24 INFO - PROCESS | 1682 | 01:21:24 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:121.70 Median:113.50 stddev:18.99 (16.7%) stddev-sans-first:19.74 01:21:24 INFO - PROCESS | 1682 | Values: 111.0 109.0 150.0 163.0 123.0 113.0 114.0 112.0 110.0 112.0 01:21:24 INFO - PROCESS | 1682 | 01:21:24 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:142.00 stddev:22.44 (15.8%) stddev-sans-first:23.09 01:21:24 INFO - PROCESS | 1682 | Values: 158.0 120.0 143.0 157.0 119.0 141.0 140.0 120.0 192.0 135.0 01:21:24 INFO - PROCESS | 1682 | 01:21:24 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:183.50 Median:185.00 stddev:3.63 (2.0%) stddev-sans-first:3.81 01:21:24 INFO - PROCESS | 1682 | Values: 185.0 185.0 186.0 184.0 184.0 186.0 185.0 185.0 174.0 181.0 01:21:24 INFO - PROCESS | 1682 | 01:21:24 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:70.50 Median:76.00 stddev:12.25 (16.1%) stddev-sans-first:12.88 01:21:24 INFO - PROCESS | 1682 | Values: 75.0 78.0 86.0 77.0 56.0 58.0 57.0 86.0 75.0 57.0 01:21:24 INFO - PROCESS | 1682 | 01:21:24 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:80.00 stddev:18.44 (23.1%) stddev-sans-first:19.49 01:21:24 INFO - PROCESS | 1682 | Values: 89.0 92.0 127.0 80.0 80.0 84.0 114.0 77.0 76.0 115.0 01:21:24 INFO - PROCESS | 1682 | 01:21:24 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:86.70 Median:89.50 stddev:3.30 (3.7%) stddev-sans-first:3.35 01:21:24 INFO - PROCESS | 1682 | Values: 84.0 90.0 83.0 90.0 84.0 90.0 84.0 89.0 83.0 90.0 01:21:24 INFO - PROCESS | 1682 | 01:21:24 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:103.00 Median:93.00 stddev:19.25 (20.7%) stddev-sans-first:20.07 01:21:24 INFO - PROCESS | 1682 | Values: 93.0 94.0 104.0 150.0 124.0 94.0 92.0 93.0 93.0 93.0 01:21:24 INFO - PROCESS | 1682 | 01:21:24 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:86.00 stddev:1.69 (2.0%) stddev-sans-first:1.79 01:21:24 INFO - PROCESS | 1682 | Values: 86.0 84.0 90.0 85.0 86.0 85.0 86.0 88.0 86.0 86.0 01:21:24 INFO - PROCESS | 1682 | 01:21:24 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:3.60 (6.5%) stddev-sans-first:3.81 01:21:24 INFO - PROCESS | 1682 | Values: 55.0 56.0 56.0 54.0 53.0 54.0 55.0 65.0 54.0 52.0 01:21:24 INFO - PROCESS | 1682 | 01:21:24 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:3.72 (5.4%) stddev-sans-first:3.37 01:21:24 INFO - PROCESS | 1682 | Values: 63.0 66.0 69.0 77.0 71.0 66.0 67.0 68.0 69.0 69.0 01:21:24 INFO - PROCESS | 1682 | 01:21:24 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:1.49 (1.8%) stddev-sans-first:1.58 01:21:24 INFO - PROCESS | 1682 | Values: 83.0 83.0 83.0 84.0 83.0 80.0 80.0 83.0 84.0 84.0 01:21:24 INFO - PROCESS | 1682 | 01:21:24 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:127.00 stddev:8.81 (6.9%) stddev-sans-first:9.26 01:21:24 INFO - PROCESS | 1682 | Values: 123.0 126.0 126.0 124.0 143.0 107.0 130.0 128.0 126.0 130.0 01:21:24 INFO - PROCESS | 1682 | 01:21:24 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.00 Median:138.50 stddev:17.54 (12.7%) stddev-sans-first:18.59 01:21:24 INFO - PROCESS | 1682 | Values: 139.0 112.0 139.0 163.0 177.0 134.0 138.0 134.0 137.0 137.0 01:21:24 INFO - PROCESS | 1682 | 01:21:24 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 01:21:24 INFO - PROCESS | 1682 | Values: 65.0 68.0 66.0 66.0 67.0 66.0 66.0 66.0 67.0 65.0 01:21:24 INFO - PROCESS | 1682 | -------- Summary: end -------- 01:21:24 INFO - PROCESS | 1682 | 01:21:25 INFO - TEST-INFO | 1682: exit 0 01:21:25 INFO - TEST-OK | kraken | took 56433ms 01:21:25 INFO - SUITE-END | took 1169s 01:21:26 INFO - Completed test suite (00:19:29) 01:21:26 INFO - Working with test: dromaeo_css 01:21:26 INFO - Generating results file: dromaeo_css 01:21:26 INFO - Working with test: kraken 01:21:26 INFO - Generating results file: kraken 01:21:26 INFO - javascript benchmark 01:21:26 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:21:26 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 01:21:26 INFO - process_Request line: dromaeo_css 7416.87 graph.html#tests=[[72,64,59]] 01:21:26 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:21:26 INFO - process_Request line: kraken 1427.60 graph.html#tests=[[232,64,59]] 01:21:26 INFO - RETURN: dromaeo_css: 7416.87 01:21:26 INFO - RETURN: kraken: 1427.60 01:21:26 INFO - javascript benchmark 01:21:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3336.499525071239, 3340.2317466982595, 3355.6141043779967, 3355.983220083899, 3411.829408529573, 5436.673799572019, 5506.4218257082985, 5511.834644960652, 5526.530244929186, 5561.3882472928, 5519.0, 5544.3346798384255, 5567.498925096751, 5678.063119585274, 5687.090065589507, 4962.6774259673, 4986.551210391064, 4996.075725990685, 5020.97489512552, 5199.376074871002, 5102.234664800272, 5131.692098474085, 5142.177251639739, 5163.225516172567, 5178.171492561191, 4944.283078953532, 4967.354243948282, 5046.5710414614805, 5057.595392368602, 5079.907819818757, 4975.875603109915, 4983.750812459362, 4987.526185012418, 5010.348654674869, 5012.04771093491, 4907.705537667715, 4932.654714170009, 4935.432425271104, 4978.079055374767, 5001.349824522825, 5369.543588794957, 5448.509634132947, 5502.5597952164135, 5537.833864984057, 5563.638363506399, 6075.756969721206, 6100.96949515254, 6103.633781973052, 6114.602550834226, 6130.662813545253, 6110.175126357974, 6191.349908259658, 6202.968985155046, 6207.193064901534, 6223.284322302948, 5565.165225216209, 5597.412271711493, 5646.265985421869, 5663.660180389149, 5677.290338707661, 6196.0705894115345, 6204.224471941007, 6209.379062093845, 6250.9062364064575, 6321.715522801485, 5919.822405327847, 5933.080372542263, 5953.553483488756, 5986.07215881539, 5992.221011268507, 6047.334793172748, 6100.267967843887, 6111.227117700271, 6114.144019837227, 6153.261608606996, 6071.180390647294, 6071.787487437919, 6077.453029227391, 6082.908756368658, 6121.602095863755, 6042.516598672096, 6044.697765111727, 6056.06131049688, 6062.545309101747, 6080.57435979486, 4752.1921273383605, 4778.856634300976, 4799.784009719501, 4800.159972004885, 4838.903221935541, 4319.244132276902, 4335.241332766753, 4366.541513141138, 4369.694121411534, 4373.693841431069, 5560.610757247035, 5593.300837395325, 5605.635633683797, 5622.803201887914, 5625.634333768292, 6102.489251635809, 6112.381899552462, 6125.571210015345, 6203.503719702413, 6238.781642642576, 5664.122061080539, 5676.063449530864, 5682.516986056232, 5684.744186511617, 5694.060480020833, 5286.259923610698, 5300.602454815904, 5306.495882891119, 5316.149416093406, 5340.626156169031, 6102.156009074812, 6142.099766648211, 6174.351693072253, 6204.968975155095, 6217.0052791553135, 6175.2589689237575, 6201.193844800147, 6202.0, 6202.7829025985675, 6209.379062093754, 6149.446549810538, 6216.502679785697, 6238.532110091671, 6243.406876346739, 6255.40573645503, 5998.1002849572915, 6011.789587364421, 6075.331713511422, 6099.146119543356, 6109.572329936862, 6167.691615419121, 6175.722092505758, 6183.5671502994355, 6192.59748116371, 6204.286507051746, 5766.106253530709, 5922.496587789914, 5958.612690175125, 5986.880262394815, 5993.9700301498215, 5801.419858014165, 5803.187553742395, 5803.912941305968, 5807.593468457168, 5859.20900678403, 5520.475554822286, 5592.664440133605, 5665.49010589049, 5678.063119585222, 5681.573881958787, 5760.395158508296, 5833.008388573868, 5834.591578589458, 5838.416158384128, 5902.1146827976145, 5842.5325973921135, 5846.386129456346, 5855.560832937632, 5856.150858125633, 5863.706814659336], "unit": "score", "name": "dojo.html", "value": 5572.201286823064}, {"lowerIsBetter": false, "replicates": [507.24673859318904, 511.25101725971444, 511.822807542652, 543.6683622989976, 626.764963138823, 37289.62710372899, 37819.621803781956, 37866.0, 37895.0, 37914.810425947864, 39774.0, 40086.599134008655, 40316.39525407121, 40328.19343613133, 40370.58702945398, 9495.952520237406, 9720.0, 9720.513974301291, 9727.07592778685, 9742.951285243564, 9651.0, 9796.951015244913, 9800.117989380955, 9811.362261453018, 9827.410355378664, 9786.6085356586, 9838.0, 9850.162736167435, 9869.210463162966, 9873.555689993931, 9737.951310243474, 9828.4102953823, 9833.754156146153, 9840.507974601313, 9853.556589953434, 9584.520773961343, 9712.660056898045, 9722.222222222275, 9723.756906077333, 9743.756406089833, 38400.0, 38504.614953850665, 38560.035999099964, 38579.80710096432, 38608.61391386107, 3134.7492200623897, 3174.8094464575784, 3201.9679803202134, 3213.052149615869, 3228.951565726516, 28042.439151217066, 28121.29696757577, 28144.43711125766, 28270.15189544317, 28763.849446022134, 2738.7437631335197, 2770.459760346733, 2807.270109771454, 2847.430513897229, 2872.339361946743, 457064.0, 458150.0, 458276.7086164581, 458382.0, 460059.0, 44080.559194408284, 61176.0, 61995.0, 62044.75910481856, 62059.0, 43120.92197695083, 43193.0, 43226.56773432288, 43240.0, 43278.13443731108, 14607.415703371746, 14888.0, 14898.925505372405, 14900.925495372454, 14909.0, 12063.638090857288, 12096.879031209752, 12116.878831211576, 12130.878691212974, 12134.575289864812, 11344.943275283737, 14010.929945350208, 14314.570562883131, 14345.856541434661, 14468.927655361866, 6094.603850749687, 6159.784407545714, 6207.255129384503, 6213.37866213375, 6214.844628884223, 904.9773755656162, 918.5407296351824, 963.0898800633474, 1013.4122209118693, 1082.1883587309517, 28709.425811483652, 28760.568591471143, 29173.41653166967, 29321.973730919315, 29469.705302946695, 859.4542465534431, 899.1458114790975, 1047.188428967541, 1080.0495563903871, 1240.0079936051122, 13968.860311396958, 13969.511067112806, 14070.301677313913, 14221.85778142226, 14229.0, 528931.0, 529807.0, 535871.0, 535975.0, 536142.0, 56773.0, 57086.42913570811, 57087.85824283491, 57174.0, 57215.0, 1311.6065180445828, 1424.6509605146598, 1457.8323492798252, 1459.3870574358796, 1514.5380658899142, 27908.30229244285, 28237.055520898317, 28656.856715716287, 29271.414571708872, 29673.703262967094, 46512.53487465217, 46758.298625521325, 46820.531794681614, 46856.0, 46899.062018760116, 353334.0, 355415.0, 355582.0, 355924.4407555891, 356187.0, 27226.86386568134, 30650.540241896837, 32229.51655725213, 32646.51030234596, 32658.673413265562, 39800.0, 40337.39493907653, 40387.19225615412, 40623.39064913969, 41462.0, 33341.16647083842, 34135.146621334665, 34550.13624659403, 34663.653363466045, 34971.65028349786, 33140.0, 34768.0, 35118.47322290219, 35747.82126089457, 35945.820270898475, 35815.46276805902, 35847.46228806518, 36014.4597831038, 36087.819560902026, 37258.813705931294, 30860.69139308668, 31167.0, 32239.516407253443, 32241.51637725389, 32340.353192935538, 23933.521329573658, 24496.14263500769, 24525.632115517925, 24806.875965620056, 24888.0], "unit": "score", "name": "ext.html", "value": 18548.357189139024}, {"lowerIsBetter": false, "replicates": [318.8820136549477, 358.31025276343036, 362.586651217612, 363.316964107478, 371.9572249191342, 19229.51926201844, 19321.903390483047, 20224.49438764028, 20238.89880550599, 20271.49321266969, 19068.809311906876, 19145.61708765824, 19818.504537386572, 19880.701789473133, 19895.104720287585, 5077.949220507785, 5675.5459563235045, 5865.648061116325, 5909.586328956974, 5928.5849990500465, 4179.435776170224, 4351.0, 4371.0, 4375.781210939456, 5761.625494342875, 6392.296847346788, 6399.36006399361, 6406.903896441557, 6414.903776443357, 6421.678916054202, 6175.258968923713, 6218.160548325964, 6286.088517165032, 6310.33741457145, 6316.873662526724, 3321.70104690579, 3699.8520059197867, 5388.7305634718105, 5410.431904650034, 5414.35027796663, 19953.501162470908, 24443.755562444327, 24695.87652061746, 24704.876475617508, 25458.72706364693, 2077.885716285604, 2136.465883529118, 2286.8056215221727, 2524.734902835213, 2870.6985766494427, 11697.649070527897, 13943.372548235353, 13949.302534873215, 14291.428342866377, 14393.136411815325, 1699.8441060079142, 1704.565335839353, 1757.635979607426, 1903.7049257365131, 1909.484439201408, 108288.0, 109969.80060398827, 111181.88818111796, 111476.44261778721, 111525.0, 11260.310953356899, 11300.26548274376, 11311.60409385684, 11329.660110196708, 11466.94266528662, 13596.728065438636, 13655.975801814704, 13666.453341866412, 13674.863251367558, 13696.383662735201, 8347.874781878276, 8493.405461617627, 8506.31949444043, 8589.527575983257, 8612.956935215409, 8590.312774977987, 8600.956995215109, 8617.784555386166, 8694.087120852346, 8698.869516957251, 4097.364908439196, 4376.846810361622, 4448.043670610769, 4464.709793863389, 4520.141173177086, 1560.66445714172, 1735.826417358254, 1806.6964620109466, 1813.3290682447316, 1863.4689113602828, 831.8170002599419, 846.724814435311, 909.3770767024477, 959.3716115944068, 1037.906588407047, 19596.216151353787, 20119.597608047756, 20181.596368072558, 20274.290399835936, 20416.0, 918.6004088221645, 962.0379620379621, 964.4020707161604, 985.6500942165571, 1055.1137044882337, 8057.949294367429, 10438.060574548326, 10657.626983055556, 10736.206990810422, 10800.837987430195, 523504.0, 532456.0, 532865.0, 588029.0, 617192.0, 108375.45812270888, 110571.0, 113176.43411782889, 118631.81368186207, 120414.19378709326, 912.3750231091724, 938.6480069973624, 1012.1245122968579, 1027.7225149209821, 1047.2407504559285, 15947.840521594635, 17953.461396158134, 17963.101844907964, 17979.550511237325, 18043.729344060113, 49178.0, 50046.49860504191, 50132.74933625309, 50822.237666434296, 54472.18291725548, 68342.65828670825, 68776.6561167191, 71204.64397677979, 75388.0, 75421.0, 7775.183605721318, 7789.260020298063, 7991.2807847294025, 8049.315808156372, 8270.917290827014, 9349.813003740022, 12784.296863672587, 12817.295048772034, 13191.472341106248, 13299.601011969657, 7249.746258880914, 11362.772744545227, 11420.31478111316, 11482.425878706199, 11507.309561426342, 11360.829587556358, 11494.0, 11505.48225329879, 11545.191836571359, 11646.475908583965, 11779.705507362385, 11834.526618935146, 11861.466234019317, 11977.940110299392, 12012.339321337411, 8022.638981245741, 8042.718504852302, 8148.144444833207, 8180.5909704515725, 8217.506949583045, 10570.41862697559, 11604.187706860439, 11857.407129643656, 11900.76198476043, 11940.582079627171], "unit": "score", "name": "jquery.html", "value": 9354.423454563903}, {"lowerIsBetter": false, "replicates": [1392.4917405147125, 1510.2901636230972, 1518.6051626577093, 1766.8586513078956, 1950.4148755373394, 8011.879821802678, 8595.74212773617, 8749.781255468617, 8751.956240218806, 8760.992485864128, 7835.80410489738, 8086.71696490623, 8668.739937801876, 8679.47923124613, 8687.0, 2172.8479006469474, 2414.8913298901502, 2452.2030340139436, 2476.2818782553036, 2477.950440991179, 2488.9875550622314, 2491.4643351679383, 2495.0019992003163, 2495.4884248728968, 2502.774750272475, 2369.218158007853, 2453.914113006045, 2471.826972111944, 2472.196536125757, 2472.950540989179, 2433.5376278507115, 2457.078595526669, 2465.9753402465926, 2478.7397323280975, 2478.95042099157, 2445.9143929962543, 2460.2496238647204, 2468.9506209875703, 2471.0486462711806, 2476.0343466048257, 8828.293736501064, 8903.065178156265, 8909.599068041955, 8921.375503714742, 8921.509316987564, 5406.864828379322, 5558.360788509332, 5603.5237004854225, 5619.943800561983, 5623.634463759842, 3193.2016995751064, 3559.0924314299946, 3681.9815900920325, 3719.9070023249365, 3747.7938713370754, 1058.444316733721, 1073.0771536478621, 1080.6974047266779, 1088.298047759191, 1090.0679918669503, 12130.090243231793, 12170.513179472811, 12186.878131218664, 12247.265164090182, 12247.69380765479, 4909.828156014594, 4952.034353301072, 5018.749062546858, 5022.522860328263, 5049.31834202378, 10247.590096396061, 10257.538410771533, 10258.384496930208, 10274.126699230648, 10282.07461328484, 5512.751926163332, 5560.277163968658, 5560.36055853582, 5580.581456390706, 5582.888342233133, 4431.778411079433, 4594.747288899142, 4742.19382704941, 4906.288588154697, 4907.460179380265, 3751.7936513491472, 3834.482344883461, 3857.3442514772555, 3861.2084522672785, 3873.806309684561, 1310.8033794930836, 1311.7442098790834, 1319.7162610038695, 1323.7881938889732, 1327.3628658244097, 1051.6897515233024, 1065.4938904020528, 1068.0280944340614, 1263.8041103628952, 1374.8418931822969, 8128.471649342774, 8189.22202390772, 8199.549024803573, 8215.712450064339, 8408.32733381328, 1179.9823002654966, 1181.645506348092, 1184.3190165654783, 1192.2310109979014, 1199.6101267088056, 6302.968485157637, 6349.809505714836, 6352.968235158887, 6359.968200159062, 6361.332060133712, 9018.639254429749, 10333.638322658671, 10561.735956600993, 10718.624848130277, 10743.979321964402, 10316.0, 10461.738456538495, 10532.15742740579, 10588.205884558689, 10620.946895265473, 8092.595370231465, 8257.298129659046, 8311.210435008665, 8324.25081742646, 8337.291330236876, 8043.1554686757045, 8044.27601515843, 8097.87853182191, 8165.469244499089, 8274.544900030556, 9471.715848524555, 9705.417674939526, 9798.85301720489, 9820.656277030555, 9936.801263974825, 9942.15491683215, 10133.44266065344, 10251.538680759533, 10269.332493387907, 10361.585536578452, 6874.346937040973, 7270.527415717961, 7468.850622987618, 7560.130584982578, 7701.998740163743, 8242.0, 8283.83432331362, 8307.501549907025, 8313.043999940084, 8356.58217089131, 6007.609505382136, 7344.632768361454, 7374.96750454926, 7427.1087469501845, 7527.0, 7261.019762332017, 7331.74338898136, 7337.491873973374, 7358.484906056525, 7370.115586129698, 7676.155622881367, 7788.0, 7790.727324543614, 7795.986521752136, 7798.454108212371, 5966.8209953699725, 7005.439564834903, 7082.150141982995, 7084.291570843081, 7090.0, 7096.822579435556, 7179.317964793337, 7192.244814294633, 7200.747973820891, 7200.927990720026], "unit": "score", "name": "mootools.html", "value": 4954.886743817722}, {"lowerIsBetter": false, "replicates": [318.2759222768202, 320.5256220793226, 326.53957919333743, 331.5093661381155, 334.333005653721, 5803.854903627406, 6433.742650293994, 6450.870982580345, 6566.277709451956, 6589.439897608697, 6435.935640643592, 6436.452901503378, 6443.935560644392, 6464.288928217892, 6478.190226221723, 4578.10726908253, 4763.14263432582, 4766.594839438651, 4769.117713223048, 4824.734639594821, 4672.532746725335, 4748.0, 4787.688800227974, 4789.204048481819, 4813.711177329372, 4768.880777980544, 4777.498362671921, 4786.234202527597, 4800.0, 4817.494163112875, 4762.809487620491, 4783.736894470802, 4786.617070634341, 4789.4971028042255, 4806.975965120169, 3415.334009868077, 3904.863329783444, 3960.0693836948294, 3972.980135099335, 3992.7803970781597, 6230.2523697156175, 6231.470325022378, 6245.437910588023, 6249.375062493714, 6255.186825712628, 5617.21359009739, 5656.444477768606, 5659.122835960433, 5664.320281566238, 5673.177389278531, 6947.027416161742, 6977.511574189809, 6979.336962988508, 6981.232064472904, 6983.092198014277, 4588.931166032512, 4598.057398233354, 4600.815967361302, 4603.447586289633, 4604.171249175147, 7082.36258736711, 7297.306755858185, 7416.0, 7420.443466740016, 7433.773427384475, 4532.79602417892, 4596.954030459653, 4604.608608268335, 4605.332226827159, 4605.355250264965, 4662.393888794435, 4663.720176789336, 4664.836730714409, 4666.556677115668, 4670.789814458358, 5551.0, 5559.694216818114, 5561.110222364402, 5562.610617256753, 5567.693776842312, 6713.597184168965, 7044.22513523512, 7055.8236044098285, 7062.929370706227, 7064.576125432491, 1591.681663667271, 1598.5284341119398, 1610.4604957339423, 1612.5243053299305, 1613.6853313603735, 1025.8820235672845, 1026.225199974015, 1040.78143589847, 1041.8437234414898, 1044.498640652491, 6439.420452159235, 6556.475481961432, 6565.967170164214, 6590.835229119214, 6604.3725846044545, 6987.541167122307, 7146.821329466701, 7246.166690830517, 7331.303526165006, 7403.407727381797, 6631.602103873783, 6646.401823835878, 6648.767293144717, 6658.700358483879, 6674.899876501856, 3828.770273783582, 3865.4974853268895, 3870.7871067091583, 3875.2636998970106, 3875.9031024224055, 7682.116556595951, 7691.1924247954275, 7692.76921692339, 7694.807629809299, 7695.0, 7228.602426866572, 7471.589062601501, 7478.027856378636, 7478.177400485943, 7480.8877866832045, 7449.366803821736, 7500.699972001168, 7501.962490187514, 7515.624218789038, 7522.849543009219, 5948.226730525004, 7289.890651640336, 7317.853642927218, 7320.194778574459, 7322.487425880137, 6933.583984960918, 7212.954121652226, 7213.639318034182, 7214.567125972459, 7214.603196824225, 7602.885956710765, 7673.923260767321, 7711.498752581064, 7721.53670779755, 7730.420218483524, 4604.6086082682, 4656.906861862676, 4658.86023419298, 4661.766911654471, 4665.440147182224, 7317.085364329459, 7328.3404493595835, 7329.0, 7331.0, 7336.119665640157, 6767.830804229934, 7039.753608623673, 7074.327938845801, 7075.028488035141, 7075.752348667772, 6986.336298051677, 7017.929820701932, 7019.29807019294, 7037.753678621224, 7042.507024508235, 6834.350736680008, 6836.692348844214, 6841.62371069596, 6845.726170953106, 6849.623270719959, 7035.0, 7040.894386584103, 7042.577445353295, 7048.400885924549, 7055.153381594037, 6615.776081424951, 6815.352541508549, 6872.828179295558, 6878.243393226641, 6886.380225779503], "unit": "score", "name": "prototype.html", "value": 5119.91727012815}, {"lowerIsBetter": false, "replicates": [616.0143769968055, 690.2683155854794, 697.8674051930129, 736.5249414127887, 760.471472326733, 14628.853711462882, 14984.0, 14987.400503979841, 14993.925030374832, 15033.173175475344, 13607.319634018284, 13659.590212293622, 13693.589192324222, 13702.657433564165, 13705.3832577534, 670.3865962644174, 687.7695971849437, 843.2031730015138, 845.4842546046922, 855.9144085591422, 844.273924424994, 856.1737922904396, 858.0304256190527, 859.7334826203897, 863.2144748279068, 893.0845882969975, 898.4968417686084, 898.6989358564889, 898.874157617934, 899.1368286445021, 716.9354758071772, 888.4536010353619, 892.1435421994893, 894.8120894612139, 899.554720413393, 667.079430386069, 671.1275342055309, 672.8586996730693, 672.9293424190488, 676.5940435738567, 14638.194899280536, 14640.853591464056, 14649.560513184515, 14657.780133298009, 14708.48520301795, 12277.69305767363, 12290.75418491634, 12317.630471085882, 12579.245245285312, 12706.983441324672, 10069.54687039085, 10112.797744045078, 10114.898851011469, 10143.391396516232, 10156.136728378096, 3482.320947415255, 3519.7360197985254, 3545.663161999606, 3562.6793588576893, 3740.5511338639267, 76375.61812190959, 77979.22020779776, 78304.21695783026, 78314.60842695751, 78716.0, 9130.25505147354, 9191.126842949909, 9281.164695177466, 9440.716778496519, 9735.513224338754, 20086.49783755418, 20336.491587710425, 20347.69478457824, 20352.49118772013, 20417.0, 7284.854302914018, 7336.449766267551, 7394.963025184948, 7421.443705052059, 7547.73582924595, 3956.149427873021, 4045.4336392905016, 4083.7958102094776, 4102.384642303678, 4198.6221240088535, 3615.4215325547784, 3616.2044350242904, 3655.2689462107683, 3655.5796083450214, 3659.8902032939054, 606.5147881694627, 671.3655595462242, 673.0778832998725, 683.2757277286092, 689.1076056506836, 532.8348212054198, 535.9678419294855, 553.3885057012025, 573.4466240078344, 623.4108767215029, 8025.357971362277, 8195.180481951757, 8235.052968908532, 8249.0, 8314.875276870851, 586.1881294407276, 595.791472984452, 596.5436441122545, 605.7365046204915, 605.9333473317931, 3700.5559332880225, 3893.240818040455, 3938.15329704115, 3947.151362457028, 3948.368261078214, 91686.0, 93671.0, 93751.0624893756, 94061.11877762407, 94198.5290073559, 78388.82416763753, 78737.0, 78961.0, 79230.0, 79831.60084199542, 69319.96020059704, 69658.9551156733, 70350.64824675844, 70638.0, 71288.0, 7722.034745656793, 7750.92249077502, 7934.325582325567, 8009.872447577492, 8052.114267430695, 35284.294314114086, 46170.307445387676, 47286.76356618195, 48786.756066219445, 49685.0, 63468.682656586425, 67242.31894202488, 68307.65846170936, 69000.6549967247, 69460.0, 9925.255605829447, 9978.550965206437, 10049.69850904474, 10633.255672103189, 10905.291156074829, 12035.097367697283, 12263.325517096646, 12387.19483233623, 12399.380030998595, 12724.236545807282, 11526.995037786066, 11562.537498499965, 11584.0, 11794.705132371759, 11887.583934562248, 11625.767484650429, 11670.649880503599, 11770.882291176978, 11983.101267404805, 11992.280463172237, 9905.900940990787, 11388.715282118013, 11620.88379116198, 11737.765244695229, 12264.811149101119, 7832.37341012729, 9564.95217523908, 9787.510624468605, 9806.656767013406, 10119.190464762949, 9086.863697044682, 9731.318807683394, 9754.756131096496, 9764.707058788248, 9767.951160244438], "unit": "score", "name": "yui.html", "value": 6786.489404205751}], "name": "dromaeo_css", "value": 7416.87009187705}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 150.0, 163.0, 123.0, 113.0, 114.0, 112.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 121.7}, {"lowerIsBetter": true, "replicates": [158.0, 120.0, 143.0, 157.0, 119.0, 141.0, 140.0, 120.0, 192.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 142.5}, {"lowerIsBetter": true, "replicates": [185.0, 185.0, 186.0, 184.0, 184.0, 186.0, 185.0, 185.0, 174.0, 181.0], "unit": "score", "name": "audio-dft", "value": 183.5}, {"lowerIsBetter": true, "replicates": [75.0, 78.0, 86.0, 77.0, 56.0, 58.0, 57.0, 86.0, 75.0, 57.0], "unit": "score", "name": "audio-fft", "value": 70.5}, {"lowerIsBetter": true, "replicates": [89.0, 92.0, 127.0, 80.0, 80.0, 84.0, 114.0, 77.0, 76.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 93.4}, {"lowerIsBetter": true, "replicates": [84.0, 90.0, 83.0, 90.0, 84.0, 90.0, 84.0, 89.0, 83.0, 90.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.7}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 104.0, 150.0, 124.0, 94.0, 92.0, 93.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 103.0}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 90.0, 85.0, 86.0, 85.0, 86.0, 88.0, 86.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 86.2}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 56.0, 54.0, 53.0, 54.0, 55.0, 65.0, 54.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [63.0, 66.0, 69.0, 77.0, 71.0, 66.0, 67.0, 68.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 84.0, 83.0, 80.0, 80.0, 83.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [123.0, 126.0, 126.0, 124.0, 143.0, 107.0, 130.0, 128.0, 126.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.3}, {"lowerIsBetter": true, "replicates": [139.0, 112.0, 139.0, 163.0, 177.0, 134.0, 138.0, 134.0, 137.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.0}, {"lowerIsBetter": true, "replicates": [65.0, 68.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken", "value": 1427.6000000000001}]} 01:21:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1427.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7416.87"}}} 01:21:26 INFO - Return code: 0 01:21:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:21:26 INFO - # TBPL SUCCESS # 01:21:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:21:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:21:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:21:26 INFO - 2016-02-26 01:21:26.616 screenresolution[1686:10369] starting screenresolution argv=screenresolution get 01:21:26 INFO - 2016-02-26 01:21:26.618 screenresolution[1686:10369] Display 0: 1600x1200x32@60 01:21:26 INFO - 2016-02-26 01:21:26.624 screenresolution[1687:10372] starting screenresolution argv=screenresolution list 01:21:26 INFO - Available Modes on Display 0 01:21:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:21:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:21:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:21:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:21:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:21:26 INFO - Intel Iris: 01:21:26 INFO - Chipset Model: Intel Iris 01:21:26 INFO - Type: GPU 01:21:26 INFO - Bus: Built-In 01:21:26 INFO - VRAM (Dynamic, Max): 1536 MB 01:21:26 INFO - Vendor: Intel (0x8086) 01:21:26 INFO - Device ID: 0x0a2e 01:21:26 INFO - Revision ID: 0x0009 01:21:26 INFO - Displays: 01:21:26 INFO - Display: 01:21:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:21:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:21:26 INFO - Display Serial Number: 1600x1200 60 01:21:26 INFO - Main Display: Yes 01:21:26 INFO - Mirror: Off 01:21:26 INFO - Online: Yes 01:21:26 INFO - Rotation: Supported 01:21:26 INFO - Return code: 0 01:21:26 INFO - Running post-action listener: _resource_record_post_action 01:21:26 INFO - Running post-run listener: _resource_record_post_run 01:21:27 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 34098688; Write bytes: 708305920; Read time: 355; Write time: 1952 01:21:27 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 405172736; Write bytes: 407259136; Read time: 30201; Write time: 769 01:21:27 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 32300544; Write bytes: 300149760; Read time: 335; Write time: 1180 01:21:27 INFO - Running post-run listener: _upload_blobber_files 01:21:27 INFO - Blob upload gear active. 01:21:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:21:27 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:27 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:27 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:28 INFO - (blobuploader) - INFO - Open directory for files ... 01:21:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:21:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:21:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:21:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:21:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:21:29 INFO - (blobuploader) - INFO - Done attempting. 01:21:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:21:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:21:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:21:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:21:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:21:30 INFO - (blobuploader) - INFO - Done attempting. 01:21:30 INFO - (blobuploader) - INFO - Iteration through files over. 01:21:30 INFO - Return code: 0 01:21:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:21:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:21:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed4dcc2328785d0d8f213204f4fcb478332c06bcbe4e95f928bae2c5ddff4f07c8aad33a35ec4676f1cfd2ab905eed35db010056837883da138994059ce9f000", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b5cd595208c17fdf5717de6a5b551442c0fb1be906cebeee07c10cb7a7d407ef584dc8dc08e4ae0b00a75fd13166f5ff7feb707042df0945dbdd624b4ade7d8"} 01:21:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:21:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:21:30 INFO - Contents: 01:21:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed4dcc2328785d0d8f213204f4fcb478332c06bcbe4e95f928bae2c5ddff4f07c8aad33a35ec4676f1cfd2ab905eed35db010056837883da138994059ce9f000", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b5cd595208c17fdf5717de6a5b551442c0fb1be906cebeee07c10cb7a7d407ef584dc8dc08e4ae0b00a75fd13166f5ff7feb707042df0945dbdd624b4ade7d8"} 01:21:30 INFO - Running post-run listener: copy_logs_to_upload_dir 01:21:30 INFO - Copying logs to upload dir... 01:21:30 INFO - mkdir: /builds/slave/test/build/upload/logs 01:21:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.872995 ========= master_lag: 53.66 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2016-02-26 01:22:24.407750) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 12 secs) (at 2016-02-26 01:22:24.412207) ========= 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.O7P4Den0YK/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.ePFzkPTsbe/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed4dcc2328785d0d8f213204f4fcb478332c06bcbe4e95f928bae2c5ddff4f07c8aad33a35ec4676f1cfd2ab905eed35db010056837883da138994059ce9f000", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b5cd595208c17fdf5717de6a5b551442c0fb1be906cebeee07c10cb7a7d407ef584dc8dc08e4ae0b00a75fd13166f5ff7feb707042df0945dbdd624b4ade7d8"} 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.011151 build_url: 'https://queue.taskcluster.net/v1/task/JpXnOptXRHiB9cYkajRKJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed4dcc2328785d0d8f213204f4fcb478332c06bcbe4e95f928bae2c5ddff4f07c8aad33a35ec4676f1cfd2ab905eed35db010056837883da138994059ce9f000", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b5cd595208c17fdf5717de6a5b551442c0fb1be906cebeee07c10cb7a7d407ef584dc8dc08e4ae0b00a75fd13166f5ff7feb707042df0945dbdd624b4ade7d8"}' ========= master_lag: 12.38 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 12 secs) (at 2016-02-26 01:22:36.799994) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-02-26 01:22:36.800295) ========= 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.O7P4Den0YK/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.ePFzkPTsbe/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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.004791 ========= master_lag: 1.52 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-02-26 01:22:38.324380) ========= ========= Started reboot skipped (results: 3, elapsed: 7 secs) (at 2016-02-26 01:22:38.324677) ========= ========= Finished reboot skipped (results: 3, elapsed: 7 secs) (at 2016-02-26 01:22:45.376776) ========= ========= Total master_lag: 68.05 =========