builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0199 starttime: 1456115035.75 results: success (0) buildid: 20160221183957 builduid: ab3cb982f6ea476098dd8e365a58deb9 revision: 19d4a6ed98e86dcf13fa64be65a8859c9e4dd8f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-21 20:23:55.745778) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-21 20:23:55.746214) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-21 20:23:55.746530) ========= 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.lZss8iCQqU/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.N9rQmC0pHf/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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.005710 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-21 20:23:55.813339) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-21 20:23:55.813648) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-21 20:23:55.946624) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 20:23:55.946980) ========= 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.lZss8iCQqU/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.N9rQmC0pHf/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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.005185 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 20:23:56.048625) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-21 20:23:56.049012) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-21 20:23:56.049465) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 20:23:56.049773) ========= 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.lZss8iCQqU/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.N9rQmC0pHf/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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-21 20:23:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.0M=0.001s 2016-02-21 20:23:56 (14.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.469206 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 20:23:56.602354) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 20:23:56.602677) ========= 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.lZss8iCQqU/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.N9rQmC0pHf/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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.019606 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 20:23:56.656794) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-21 20:23:56.665225) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 19d4a6ed98e86dcf13fa64be65a8859c9e4dd8f1 --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 19d4a6ed98e86dcf13fa64be65a8859c9e4dd8f1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lZss8iCQqU/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.N9rQmC0pHf/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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-21 20:23:56,743 truncating revision to first 12 chars 2016-02-21 20:23:56,743 Setting DEBUG logging. 2016-02-21 20:23:56,743 attempt 1/10 2016-02-21 20:23:56,743 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/19d4a6ed98e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-21 20:23:57,800 unpacking tar archive at: fx-team-19d4a6ed98e8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.302434 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-21 20:23:57.991735) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-21 20:23:57.992178) ========= echo 19d4a6ed98e86dcf13fa64be65a8859c9e4dd8f1 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'19d4a6ed98e86dcf13fa64be65a8859c9e4dd8f1'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lZss8iCQqU/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.N9rQmC0pHf/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 19d4a6ed98e86dcf13fa64be65a8859c9e4dd8f1 program finished with exit code 0 elapsedTime=0.004847 script_repo_revision: '19d4a6ed98e86dcf13fa64be65a8859c9e4dd8f1' ========= master_lag: 0.07 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-21 20:23:58.064636) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-21 20:23:58.064971) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-21 20:23:58.098808) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-02-21 20:23:58.099167) ========= /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.lZss8iCQqU/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.N9rQmC0pHf/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 20:23:58 INFO - MultiFileLogger online at 20160221 20:23:58 in /builds/slave/test 20:23:58 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 20:23:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:23:58 INFO - {'append_to_log': False, 20:23:58 INFO - 'base_work_dir': '/builds/slave/test', 20:23:58 INFO - 'blob_upload_branch': 'Fx-Team', 20:23:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:23:58 INFO - 'branch': 'Fx-Team', 20:23:58 INFO - 'buildbot_json_path': 'buildprops.json', 20:23:58 INFO - 'config_files': ('talos/mac_config.py',), 20:23:58 INFO - 'default_actions': ('clobber', 20:23:58 INFO - 'read-buildbot-config', 20:23:58 INFO - 'download-and-extract', 20:23:58 INFO - 'populate-webroot', 20:23:58 INFO - 'create-virtualenv', 20:23:58 INFO - 'install', 20:23:58 INFO - 'run-tests'), 20:23:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:23:58 INFO - 'download_minidump_stackwalk': True, 20:23:58 INFO - 'download_symbols': 'ondemand', 20:23:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:23:58 INFO - 'tooltool.py': '/tools/tooltool.py', 20:23:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:23:58 INFO - '/tools/misc-python/virtualenv.py')}, 20:23:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:23:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:23:58 INFO - 'installer_path': 'installer.exe', 20:23:58 INFO - 'log_level': 'info', 20:23:58 INFO - 'log_name': 'talos', 20:23:58 INFO - 'log_to_console': True, 20:23:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:23:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:23:58 INFO - 'opt_config_files': (), 20:23:58 INFO - 'pip_index': False, 20:23:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:23:58 INFO - 'cmd': ('bash', 20:23:58 INFO - '-c', 20:23:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:23:58 INFO - 'enabled': True, 20:23:58 INFO - 'halt_on_failure': False, 20:23:58 INFO - 'name': 'check_screen_resolution'},), 20:23:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:23:58 INFO - 'cmd': ('bash', 20:23:58 INFO - '-c', 20:23:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:23:58 INFO - 'enabled': True, 20:23:58 INFO - 'halt_on_failure': False, 20:23:58 INFO - 'name': 'check_screen_resolution'},), 20:23:58 INFO - 'run_cmd_checks_enabled': True, 20:23:58 INFO - 'sps_profile': False, 20:23:58 INFO - 'sps_profile_interval': 0, 20:23:58 INFO - 'suite': 'dromaeojs', 20:23:58 INFO - 'system_bits': '32', 20:23:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:23:58 INFO - 'title': 't-yosemite-r7-0199', 20:23:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:23:58 INFO - 'use_talos_json': True, 20:23:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:23:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:23:58 INFO - 'work_dir': 'build'} 20:23:58 INFO - ##### 20:23:58 INFO - ##### Running clobber step. 20:23:58 INFO - ##### 20:23:58 INFO - Running pre-action listener: _resource_record_pre_action 20:23:58 INFO - Running main action method: clobber 20:23:58 INFO - rmtree: /builds/slave/test/build 20:23:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:23:58 INFO - Running post-action listener: _resource_record_post_action 20:23:58 INFO - ##### 20:23:58 INFO - ##### Running read-buildbot-config step. 20:23:58 INFO - ##### 20:23:58 INFO - Running pre-action listener: _resource_record_pre_action 20:23:58 INFO - Running main action method: read_buildbot_config 20:23:58 INFO - Using buildbot properties: 20:23:58 INFO - { 20:23:58 INFO - "project": "", 20:23:58 INFO - "product": "firefox", 20:23:58 INFO - "script_repo_revision": "production", 20:23:58 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 20:23:58 INFO - "repository": "", 20:23:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 20:23:58 INFO - "buildid": "20160221183957", 20:23:58 INFO - "pgo_build": "False", 20:23:58 INFO - "basedir": "/builds/slave/test", 20:23:58 INFO - "buildnumber": 397, 20:23:58 INFO - "slavename": "t-yosemite-r7-0199", 20:23:58 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 20:23:58 INFO - "platform": "yosemite_r7", 20:23:58 INFO - "scheduler": "tests-fx-team-macosx64-talos", 20:23:58 INFO - "branch": "fx-team", 20:23:58 INFO - "repo_path": "integration/fx-team", 20:23:58 INFO - "revision": "19d4a6ed98e86dcf13fa64be65a8859c9e4dd8f1", 20:23:58 INFO - "stage_platform": "macosx64", 20:23:58 INFO - "builduid": "ab3cb982f6ea476098dd8e365a58deb9", 20:23:58 INFO - "slavebuilddir": "test" 20:23:58 INFO - } 20:23:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 20:23:58 INFO - Running post-action listener: _resource_record_post_action 20:23:58 INFO - ##### 20:23:58 INFO - ##### Running download-and-extract step. 20:23:58 INFO - ##### 20:23:58 INFO - Running pre-action listener: _resource_record_pre_action 20:23:58 INFO - Running main action method: download_and_extract 20:23:58 INFO - mkdir: /builds/slave/test/build/tests 20:23:58 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')]} 20:23:58 INFO - https://queue.taskcluster.net/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:23:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/test_packages.json 20:23:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/test_packages.json 20:23:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 20:23:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 20:23:59 INFO - Downloaded 1277 bytes. 20:23:59 INFO - Reading from file /builds/slave/test/build/test_packages.json 20:23:59 INFO - Using the following test package requirements: 20:23:59 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 20:23:59 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:23:59 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 20:23:59 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:23:59 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 20:23:59 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:23:59 INFO - u'jsshell-mac.zip'], 20:23:59 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:23:59 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 20:23:59 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 20:23:59 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:23:59 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 20:23:59 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:23:59 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 20:23:59 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:23:59 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 20:23:59 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 20:23:59 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:23:59 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 20:23:59 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:59 INFO - https://queue.taskcluster.net/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:23:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 20:23:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 20:23:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/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 20:23:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/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 20:24:01 INFO - Downloaded 17825273 bytes. 20:24:01 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'] 20:24:01 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 20:24:04 INFO - Return code: 0 20:24:04 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 20:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:04 INFO - https://queue.taskcluster.net/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:24:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 20:24:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 20:24:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/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 20:24:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/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 20:24:09 INFO - Downloaded 17825273 bytes. 20:24:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:24:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 20:24:12 INFO - Return code: 0 20:24: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')]} 20:24:12 INFO - https://queue.taskcluster.net/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 20:24:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 20:24:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 20:24:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/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 20:24:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/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 20:24:13 INFO - Downloaded 10707015 bytes. 20:24:13 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'] 20:24:13 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 20:24:14 INFO - Return code: 0 20:24:14 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')]} 20:24:14 INFO - https://queue.taskcluster.net/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 20:24:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 20:24:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 20:24:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 20:24:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/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 20:24:18 INFO - Downloaded 111279271 bytes. 20:24:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 20:24:18 INFO - mkdir: /builds/slave/test/properties 20:24:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:24:18 INFO - Writing to file /builds/slave/test/properties/build_url 20:24:18 INFO - Contents: 20:24:18 INFO - build_url:https://queue.taskcluster.net/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 20:24:19 INFO - Running post-action listener: _resource_record_post_action 20:24:19 INFO - Running post-action listener: set_extra_try_arguments 20:24:19 INFO - ##### 20:24:19 INFO - ##### Running populate-webroot step. 20:24:19 INFO - ##### 20:24:19 INFO - Running pre-action listener: _resource_record_pre_action 20:24:19 INFO - Running main action method: populate_webroot 20:24:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:24:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:24:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:24:19 INFO - '--tppagecycles', 20:24:19 INFO - '7'], 20:24:19 INFO - 'tests': ['tsvgm']}}, 20:24:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:24:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:24:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:24:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 20:24:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:24:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:24:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:24:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:19 INFO - 'talos_options': ['--e10s'], 20:24:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:24:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:19 INFO - 'tests': ['damp', 'tps']}, 20:24:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:19 INFO - 'talos_options': ['--e10s'], 20:24:19 INFO - 'tests': ['damp', 'tps']}, 20:24:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:24:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:24:19 INFO - 'other': {'tests': ['a11yr', 20:24:19 INFO - 'ts_paint', 20:24:19 INFO - 'tpaint', 20:24:19 INFO - 'sessionrestore', 20:24:19 INFO - 'sessionrestore_no_auto_restore']}, 20:24:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:24:19 INFO - 'tests': ['a11yr', 20:24:19 INFO - 'ts_paint', 20:24:19 INFO - 'tpaint', 20:24:19 INFO - 'sessionrestore', 20:24:19 INFO - 'sessionrestore_no_auto_restore']}, 20:24:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:24:19 INFO - 'tests': ['a11yr', 20:24:19 INFO - 'ts_paint', 20:24:19 INFO - 'tpaint', 20:24:19 INFO - 'sessionrestore', 20:24:19 INFO - 'sessionrestore_no_auto_restore']}, 20:24:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:24:19 INFO - 'tests': ['a11yr', 20:24:19 INFO - 'ts_paint', 20:24:19 INFO - 'tpaint', 20:24:19 INFO - 'sessionrestore', 20:24:19 INFO - 'sessionrestore_no_auto_restore']}, 20:24:19 INFO - 'other_l64': {'tests': ['a11yr', 20:24:19 INFO - 'ts_paint', 20:24:19 INFO - 'tpaint', 20:24:19 INFO - 'sessionrestore', 20:24:19 INFO - 'sessionrestore_no_auto_restore']}, 20:24:19 INFO - 'other_nol64': {'tests': ['a11yr', 20:24:19 INFO - 'ts_paint', 20:24:19 INFO - 'tpaint', 20:24:19 INFO - 'sessionrestore', 20:24:19 INFO - 'sessionrestore_no_auto_restore']}, 20:24:19 INFO - 'svgr': {'tests': ['tsvgx', 20:24:19 INFO - 'tsvgr_opacity', 20:24:19 INFO - 'tart', 20:24:19 INFO - 'tscrollx', 20:24:19 INFO - 'cart']}, 20:24:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:24:19 INFO - 'tests': ['tsvgx', 20:24:19 INFO - 'tsvgr_opacity', 20:24:19 INFO - 'tart', 20:24:19 INFO - 'tscrollx', 20:24:19 INFO - 'cart']}, 20:24:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:19 INFO - 'tests': ['tp5o']}, 20:24:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:19 INFO - 'talos_options': ['--e10s'], 20:24:19 INFO - 'tests': ['tp5o']}, 20:24:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:19 INFO - 'talos_options': ['--xperf_path', 20:24:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:24:19 INFO - 'tests': ['tp5n']}, 20:24:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:19 INFO - 'talos_options': ['--e10s', 20:24:19 INFO - '--xperf_path', 20:24:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:24:19 INFO - 'tests': ['tp5n']}}, 20:24:19 INFO - 'talos.zip': {'path': '', 20:24:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:24:19 INFO - Running post-action listener: _resource_record_post_action 20:24:19 INFO - ##### 20:24:19 INFO - ##### Running create-virtualenv step. 20:24:19 INFO - ##### 20:24:19 INFO - Running pre-action listener: _resource_record_pre_action 20:24:19 INFO - Running main action method: create_virtualenv 20:24:19 INFO - Creating virtualenv /builds/slave/test/build/venv 20:24:19 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 20:24:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:24:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:24:19 INFO - Using real prefix '/tools/python27' 20:24:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:24:19 INFO - Installing distribute.............................................................................................................................................................................................done. 20:24:22 INFO - Installing pip.................done. 20:24:22 INFO - Return code: 0 20:24:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:24:22 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')]} 20:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:22 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')]} 20:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:22 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 0x10ef32a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb9b4ccd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edd6d30>, '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 0x10ebfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10edcdb20>, '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.lZss8iCQqU/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.N9rQmC0pHf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 20:24:22 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 20:24:22 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 20:24:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lZss8iCQqU/Render', 20:24:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:22 INFO - 'HOME': '/Users/cltbld', 20:24:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:22 INFO - 'LOGNAME': 'cltbld', 20:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:22 INFO - 'MOZ_NO_REMOTE': '1', 20:24:22 INFO - 'NO_EM_RESTART': '1', 20:24:22 INFO - 'PAGER': '/bin/cat', 20:24:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:22 INFO - 'PWD': '/builds/slave/test', 20:24:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:22 INFO - 'SHELL': '/bin/bash', 20:24:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N9rQmC0pHf/Listeners', 20:24:22 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 20:24:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:22 INFO - 'USER': 'cltbld', 20:24:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:22 INFO - 'XPC_FLAGS': '0x0', 20:24:22 INFO - 'XPC_SERVICE_NAME': '0', 20:24:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:23 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 20:24:23 INFO - Cleaning up... 20:24:23 INFO - Return code: 0 20:24:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:24: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')]} 20:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24: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')]} 20:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:23 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 0x10ef32a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb9b4ccd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edd6d30>, '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 0x10ebfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10edcdb20>, '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.lZss8iCQqU/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.N9rQmC0pHf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 20:24:23 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 20:24:23 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 20:24:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lZss8iCQqU/Render', 20:24:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:23 INFO - 'HOME': '/Users/cltbld', 20:24:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:23 INFO - 'LOGNAME': 'cltbld', 20:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:23 INFO - 'MOZ_NO_REMOTE': '1', 20:24:23 INFO - 'NO_EM_RESTART': '1', 20:24:23 INFO - 'PAGER': '/bin/cat', 20:24:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:23 INFO - 'PWD': '/builds/slave/test', 20:24:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:23 INFO - 'SHELL': '/bin/bash', 20:24:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N9rQmC0pHf/Listeners', 20:24:23 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 20:24:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:23 INFO - 'USER': 'cltbld', 20:24:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:23 INFO - 'XPC_FLAGS': '0x0', 20:24:23 INFO - 'XPC_SERVICE_NAME': '0', 20:24:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:23 INFO - Downloading/unpacking psutil>=0.7.1 20:24:23 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 20:24:23 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 20:24:23 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 20:24:23 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 20:24:23 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 20:24:23 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 20:24:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:24:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:24:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:24:26 INFO - Installing collected packages: psutil 20:24:26 INFO - Running setup.py install for psutil 20:24:26 INFO - building 'psutil._psutil_osx' extension 20:24:26 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 20:24:27 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 20:24:27 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 20:24:27 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 20:24:27 INFO - building 'psutil._psutil_posix' extension 20:24:27 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 20:24:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:24:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:24:27 INFO - ^ 20:24:27 INFO - 1 warning generated. 20:24:27 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 20:24:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:24:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:24:27 INFO - Successfully installed psutil 20:24:27 INFO - Cleaning up... 20:24:27 INFO - Return code: 0 20:24:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:24:27 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')]} 20:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:27 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')]} 20:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:27 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 0x10ef32a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb9b4ccd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edd6d30>, '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 0x10ebfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10edcdb20>, '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.lZss8iCQqU/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.N9rQmC0pHf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 20:24:27 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 20:24:27 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 20:24:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lZss8iCQqU/Render', 20:24:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:27 INFO - 'HOME': '/Users/cltbld', 20:24:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:27 INFO - 'LOGNAME': 'cltbld', 20:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:27 INFO - 'MOZ_NO_REMOTE': '1', 20:24:27 INFO - 'NO_EM_RESTART': '1', 20:24:27 INFO - 'PAGER': '/bin/cat', 20:24:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:27 INFO - 'PWD': '/builds/slave/test', 20:24:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:27 INFO - 'SHELL': '/bin/bash', 20:24:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N9rQmC0pHf/Listeners', 20:24:27 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 20:24:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:27 INFO - 'USER': 'cltbld', 20:24:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:27 INFO - 'XPC_FLAGS': '0x0', 20:24:27 INFO - 'XPC_SERVICE_NAME': '0', 20:24:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:24:27 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 20:24:27 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 20:24:27 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 20:24:27 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 20:24:27 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 20:24:27 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 20:24:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:24:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:24:30 INFO - Installing collected packages: mozsystemmonitor 20:24:30 INFO - Running setup.py install for mozsystemmonitor 20:24:30 INFO - Successfully installed mozsystemmonitor 20:24:30 INFO - Cleaning up... 20:24:30 INFO - Return code: 0 20:24:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ef32a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb9b4ccd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edd6d30>, '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 0x10ebfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10edcdb20>, '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.lZss8iCQqU/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.N9rQmC0pHf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 20:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:24:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lZss8iCQqU/Render', 20:24:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:30 INFO - 'HOME': '/Users/cltbld', 20:24:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:30 INFO - 'LOGNAME': 'cltbld', 20:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:30 INFO - 'MOZ_NO_REMOTE': '1', 20:24:30 INFO - 'NO_EM_RESTART': '1', 20:24:30 INFO - 'PAGER': '/bin/cat', 20:24:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:30 INFO - 'PWD': '/builds/slave/test', 20:24:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:30 INFO - 'SHELL': '/bin/bash', 20:24:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N9rQmC0pHf/Listeners', 20:24:30 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 20:24:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:30 INFO - 'USER': 'cltbld', 20:24:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:30 INFO - 'XPC_FLAGS': '0x0', 20:24:30 INFO - 'XPC_SERVICE_NAME': '0', 20:24:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:30 INFO - Downloading/unpacking blobuploader==1.2.4 20:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:33 INFO - Downloading blobuploader-1.2.4.tar.gz 20:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:24:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:24:33 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 20:24:33 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 20:24:33 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 20:24:33 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 20:24:33 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 20:24:33 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 20:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:24:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:24:33 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 20:24:33 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 20:24:33 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 20:24:33 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 20:24:33 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 20:24:33 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 20:24:34 INFO - Downloading docopt-0.6.1.tar.gz 20:24:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:24:34 INFO - Installing collected packages: blobuploader, requests, docopt 20:24:34 INFO - Running setup.py install for blobuploader 20:24:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:24:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:24:34 INFO - Running setup.py install for requests 20:24:35 INFO - Running setup.py install for docopt 20:24:35 INFO - Successfully installed blobuploader requests docopt 20:24:35 INFO - Cleaning up... 20:24:35 INFO - Return code: 0 20:24:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:35 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 0x10ef32a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb9b4ccd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edd6d30>, '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 0x10ebfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10edcdb20>, '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.lZss8iCQqU/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.N9rQmC0pHf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 20:24:35 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 20:24:35 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 20:24:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lZss8iCQqU/Render', 20:24:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:35 INFO - 'HOME': '/Users/cltbld', 20:24:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:35 INFO - 'LOGNAME': 'cltbld', 20:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:35 INFO - 'MOZ_NO_REMOTE': '1', 20:24:35 INFO - 'NO_EM_RESTART': '1', 20:24:35 INFO - 'PAGER': '/bin/cat', 20:24:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:35 INFO - 'PWD': '/builds/slave/test', 20:24:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:35 INFO - 'SHELL': '/bin/bash', 20:24:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N9rQmC0pHf/Listeners', 20:24:35 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 20:24:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:35 INFO - 'USER': 'cltbld', 20:24:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:35 INFO - 'XPC_FLAGS': '0x0', 20:24:35 INFO - 'XPC_SERVICE_NAME': '0', 20:24:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:24:35 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-A9WGUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:24:35 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-AEYQum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:24:35 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-Q5tJnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:24:35 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-7DbTvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:24:35 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-ms1oFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:24:36 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-_WxCEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:24:36 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-HEbj4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:24:36 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-baOWd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:24:36 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-dSz9dM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:24:36 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-p53MNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:24:36 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-TnjCrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:24:36 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-rNhaok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:24:36 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-8RXB_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:24:36 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-bixJr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:37 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-lwVDpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:24:37 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-sIerxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:24:37 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-2tI1te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:24:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:24:37 INFO - Running setup.py install for manifestparser 20:24:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:24:37 INFO - Running setup.py install for mozcrash 20:24:37 INFO - Running setup.py install for mozdebug 20:24:37 INFO - Running setup.py install for mozdevice 20:24:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:24:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:24:37 INFO - Running setup.py install for mozfile 20:24:38 INFO - Running setup.py install for mozhttpd 20:24:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:24:38 INFO - Running setup.py install for mozinfo 20:24:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:24:38 INFO - Running setup.py install for mozInstall 20:24:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:24:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:24:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:24:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:24:38 INFO - Running setup.py install for mozleak 20:24:38 INFO - Running setup.py install for mozlog 20:24:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:24:38 INFO - Running setup.py install for moznetwork 20:24:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:24:38 INFO - Running setup.py install for mozprocess 20:24:39 INFO - Running setup.py install for mozprofile 20:24:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:24:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:24:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:24:39 INFO - Running setup.py install for mozrunner 20:24:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:24:39 INFO - Running setup.py install for mozscreenshot 20:24:39 INFO - Running setup.py install for moztest 20:24:39 INFO - Running setup.py install for mozversion 20:24:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:24:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:24:39 INFO - Cleaning up... 20:24:39 INFO - Return code: 0 20:24:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:24:39 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')]} 20:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:39 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')]} 20:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:39 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 0x10ef32a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb9b4ccd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edd6d30>, '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 0x10ebfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10edcdb20>, '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.lZss8iCQqU/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.N9rQmC0pHf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 20:24:39 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 20:24:39 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 20:24:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lZss8iCQqU/Render', 20:24:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:39 INFO - 'HOME': '/Users/cltbld', 20:24:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:39 INFO - 'LOGNAME': 'cltbld', 20:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:39 INFO - 'MOZ_NO_REMOTE': '1', 20:24:39 INFO - 'NO_EM_RESTART': '1', 20:24:39 INFO - 'PAGER': '/bin/cat', 20:24:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:39 INFO - 'PWD': '/builds/slave/test', 20:24:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:39 INFO - 'SHELL': '/bin/bash', 20:24:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N9rQmC0pHf/Listeners', 20:24:39 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 20:24:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:39 INFO - 'USER': 'cltbld', 20:24:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:39 INFO - 'XPC_FLAGS': '0x0', 20:24:39 INFO - 'XPC_SERVICE_NAME': '0', 20:24:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:24:40 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-MKn6Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:24:40 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)) 20:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:24:40 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-Z9t7P3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:24:40 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)) 20:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:24:40 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-TOq8rI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:24:40 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)) 20:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:24:40 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-pWkXW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:24:40 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)) 20:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:24:40 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-aXeSJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:24:40 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)) 20:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:24:40 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-IX4dwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:24:40 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)) 20:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:24:40 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-oZjCMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:24:40 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)) 20:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:24:40 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-5iJv3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:24:40 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)) 20:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:24:40 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-toyQKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:24:41 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)) 20:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:24:41 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-RRMvkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:24:41 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)) 20:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:24:41 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-l6jTch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:24:41 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)) 20:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:24:41 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-lGZD8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:24:41 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)) 20:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:24:41 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-d2WWSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:24:41 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)) 20:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:24:41 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-_okXVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:24:41 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)) 20:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:41 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-ihNnNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:41 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)) 20:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:24:41 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-qUvr_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:24:41 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)) 20:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:24:41 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-zQVVHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:24:41 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)) 20:24:41 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)) 20:24:41 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)) 20:24:41 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)) 20:24:41 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)) 20:24:41 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)) 20:24:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:44 INFO - Downloading blessings-1.6.tar.gz 20:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:24:44 INFO - Installing collected packages: blessings 20:24:44 INFO - Running setup.py install for blessings 20:24:44 INFO - Successfully installed blessings 20:24:44 INFO - Cleaning up... 20:24:44 INFO - Return code: 0 20:24:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:24:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:24:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:24:44 INFO - Reading from file tmpfile_stdout 20:24:44 INFO - Current package versions: 20:24:44 INFO - blessings == 1.6 20:24:44 INFO - blobuploader == 1.2.4 20:24:44 INFO - docopt == 0.6.1 20:24:44 INFO - manifestparser == 1.1 20:24:44 INFO - mozInstall == 1.12 20:24:44 INFO - mozcrash == 0.16 20:24:44 INFO - mozdebug == 0.1 20:24:44 INFO - mozdevice == 0.48 20:24:44 INFO - mozfile == 1.2 20:24:44 INFO - mozhttpd == 0.7 20:24:44 INFO - mozinfo == 0.9 20:24:44 INFO - mozleak == 0.1 20:24:44 INFO - mozlog == 3.1 20:24:44 INFO - moznetwork == 0.27 20:24:44 INFO - mozprocess == 0.22 20:24:44 INFO - mozprofile == 0.28 20:24:44 INFO - mozrunner == 6.11 20:24:44 INFO - mozscreenshot == 0.1 20:24:44 INFO - mozsystemmonitor == 0.0 20:24:44 INFO - moztest == 0.7 20:24:44 INFO - mozversion == 1.4 20:24:44 INFO - psutil == 3.1.1 20:24:44 INFO - requests == 1.2.3 20:24:44 INFO - wsgiref == 0.1.2 20:24:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:44 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 0x10ef32a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb9b4ccd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edd6d30>, '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 0x10ebfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10edcdb20>, '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.lZss8iCQqU/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.N9rQmC0pHf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 20:24:44 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 20:24:44 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 20:24:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lZss8iCQqU/Render', 20:24:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:44 INFO - 'HOME': '/Users/cltbld', 20:24:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:44 INFO - 'LOGNAME': 'cltbld', 20:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:44 INFO - 'MOZ_NO_REMOTE': '1', 20:24:44 INFO - 'NO_EM_RESTART': '1', 20:24:44 INFO - 'PAGER': '/bin/cat', 20:24:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:44 INFO - 'PWD': '/builds/slave/test', 20:24:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:44 INFO - 'SHELL': '/bin/bash', 20:24:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N9rQmC0pHf/Listeners', 20:24:44 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 20:24:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:44 INFO - 'USER': 'cltbld', 20:24:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:44 INFO - 'XPC_FLAGS': '0x0', 20:24:44 INFO - 'XPC_SERVICE_NAME': '0', 20:24:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:45 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)) 20:24:45 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)) 20:24:45 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)) 20:24:45 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)) 20:24:45 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)) 20:24:45 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)) 20:24:45 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)) 20:24:45 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)) 20:24:45 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)) 20:24:45 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)) 20:24:45 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)) 20:24:45 INFO - Cleaning up... 20:24:45 INFO - Return code: 0 20:24:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:24:45 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')]} 20:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:45 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')]} 20:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:45 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 0x10ef32a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb9b4ccd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edd6d30>, '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 0x10ebfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10edcdb20>, '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.lZss8iCQqU/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.N9rQmC0pHf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 20:24:45 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 20:24:45 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 20:24:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lZss8iCQqU/Render', 20:24:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:45 INFO - 'HOME': '/Users/cltbld', 20:24:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:45 INFO - 'LOGNAME': 'cltbld', 20:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:45 INFO - 'MOZ_NO_REMOTE': '1', 20:24:45 INFO - 'NO_EM_RESTART': '1', 20:24:45 INFO - 'PAGER': '/bin/cat', 20:24:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:45 INFO - 'PWD': '/builds/slave/test', 20:24:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:45 INFO - 'SHELL': '/bin/bash', 20:24:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N9rQmC0pHf/Listeners', 20:24:45 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 20:24:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:45 INFO - 'USER': 'cltbld', 20:24:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:45 INFO - 'XPC_FLAGS': '0x0', 20:24:45 INFO - 'XPC_SERVICE_NAME': '0', 20:24:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:45 INFO - Downloading/unpacking jsonschema 20:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:24:47 INFO - Downloading/unpacking functools32 (from jsonschema) 20:24:47 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 20:24:47 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 20:24:47 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 20:24:47 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 20:24:47 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 20:24:47 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 20:24:48 INFO - Downloading functools32-3.2.3-2.tar.gz 20:24:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:24:48 INFO - warning: no files found matching '*.txt' 20:24:48 INFO - no previously-included directories found matching 'build' 20:24:48 INFO - no previously-included directories found matching 'dist' 20:24:48 INFO - no previously-included directories found matching '.git*' 20:24:48 INFO - Installing collected packages: jsonschema, functools32 20:24:48 INFO - Running setup.py install for functools32 20:24:48 INFO - warning: no files found matching '*.txt' 20:24:48 INFO - no previously-included directories found matching 'build' 20:24:48 INFO - no previously-included directories found matching 'dist' 20:24:48 INFO - no previously-included directories found matching '.git*' 20:24:48 INFO - Successfully installed jsonschema functools32 20:24:48 INFO - Cleaning up... 20:24:48 INFO - Return code: 0 20:24:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef32a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb9b4ccd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edd6d30>, '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 0x10ebfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10edcdb20>, '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.lZss8iCQqU/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.N9rQmC0pHf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 20:24:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:24:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lZss8iCQqU/Render', 20:24:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:48 INFO - 'HOME': '/Users/cltbld', 20:24:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:48 INFO - 'LOGNAME': 'cltbld', 20:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:48 INFO - 'MOZ_NO_REMOTE': '1', 20:24:48 INFO - 'NO_EM_RESTART': '1', 20:24:48 INFO - 'PAGER': '/bin/cat', 20:24:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:48 INFO - 'PWD': '/builds/slave/test', 20:24:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:48 INFO - 'SHELL': '/bin/bash', 20:24:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N9rQmC0pHf/Listeners', 20:24:48 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 20:24:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:48 INFO - 'USER': 'cltbld', 20:24:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:48 INFO - 'XPC_FLAGS': '0x0', 20:24:48 INFO - 'XPC_SERVICE_NAME': '0', 20:24:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:48 INFO - Downloading/unpacking flake8 20:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:24:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:24:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:24:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:24:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:24:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:24:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:24:52 INFO - no previously-included directories found matching 'docs/_build' 20:24:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:24:52 INFO - Running setup.py install for pep8 20:24:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:24:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:24:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:24:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:24:52 INFO - no previously-included directories found matching 'docs/_build' 20:24:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:24:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:24:52 INFO - Cleaning up... 20:24:52 INFO - Return code: 0 20:24:52 INFO - Running post-action listener: _resource_record_post_action 20:24:52 INFO - Running post-action listener: _start_resource_monitoring 20:24:52 INFO - Starting resource monitoring. 20:24:52 INFO - ##### 20:24:52 INFO - ##### Running install step. 20:24:52 INFO - ##### 20:24:52 INFO - Running pre-action listener: _resource_record_pre_action 20:24:52 INFO - Running main action method: install 20:24:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:24:52 INFO - Reading from file tmpfile_stdout 20:24:52 INFO - Detecting whether we're running mozinstall >=1.0... 20:24:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:24:52 INFO - Reading from file tmpfile_stdout 20:24:52 INFO - Output received: 20:24:52 INFO - Usage: mozinstall [options] installer 20:24:52 INFO - Options: 20:24:52 INFO - -h, --help show this help message and exit 20:24:52 INFO - -d DEST, --destination=DEST 20:24:52 INFO - Directory to install application into. [default: 20:24:52 INFO - "/builds/slave/test"] 20:24:52 INFO - --app=APP Application being installed. [default: firefox] 20:24:52 INFO - mkdir: /builds/slave/test/build/application 20:24:52 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'] 20:24:52 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 20:25:26 INFO - Reading from file tmpfile_stdout 20:25:26 INFO - Output received: 20:25:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:25:26 INFO - Running post-action listener: _resource_record_post_action 20:25:26 INFO - ##### 20:25:26 INFO - ##### Running run-tests step. 20:25:26 INFO - ##### 20:25:26 INFO - Running pre-action listener: _resource_record_pre_action 20:25:26 INFO - Running main action method: run_tests 20:25:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:25:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:25:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:25:26 INFO - 2016-02-21 20:25:26.812 screenresolution[2100:14800] starting screenresolution argv=screenresolution get 20:25:26 INFO - 2016-02-21 20:25:26.815 screenresolution[2100:14800] Display 0: 1600x1200x32@60 20:25:26 INFO - 2016-02-21 20:25:26.820 screenresolution[2101:14802] starting screenresolution argv=screenresolution list 20:25:26 INFO - Available Modes on Display 0 20:25:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:25:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:25:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:25:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:25:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:25:27 INFO - Intel Iris: 20:25:27 INFO - Chipset Model: Intel Iris 20:25:27 INFO - Type: GPU 20:25:27 INFO - Bus: Built-In 20:25:27 INFO - VRAM (Dynamic, Max): 1536 MB 20:25:27 INFO - Vendor: Intel (0x8086) 20:25:27 INFO - Device ID: 0x0a2e 20:25:27 INFO - Revision ID: 0x0009 20:25:27 INFO - Displays: 20:25:27 INFO - Display: 20:25:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:25:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:25:27 INFO - Display Serial Number: 1600x1200 60 20:25:27 INFO - Main Display: Yes 20:25:27 INFO - Mirror: Off 20:25:27 INFO - Online: Yes 20:25:27 INFO - Rotation: Supported 20:25:27 INFO - Return code: 0 20:25:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:25:27 INFO - Python 2.7.3 20:25:27 INFO - Return code: 0 20:25:27 INFO - grabbing minidump binary from tooltool 20:25:27 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')]} 20:25:27 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 0x10edd6d30>, '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 0x10ebfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10edcdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:25:27 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 20:25:27 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 20:25:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:25:27 INFO - Return code: 0 20:25:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:25:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:25:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:25:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:25:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:25:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:25:28 INFO - Return code: 0 20:25:28 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/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0199', '--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 20:25:28 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/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0199 --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 20:25:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lZss8iCQqU/Render', 20:25:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:28 INFO - 'HOME': '/Users/cltbld', 20:25:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:28 INFO - 'LOGNAME': 'cltbld', 20:25:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:25:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:28 INFO - 'MOZ_NO_REMOTE': '1', 20:25:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:25:28 INFO - 'NO_EM_RESTART': '1', 20:25:28 INFO - 'PAGER': '/bin/cat', 20:25:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:28 INFO - 'PWD': '/builds/slave/test', 20:25:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:25:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:28 INFO - 'SHELL': '/bin/bash', 20:25:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N9rQmC0pHf/Listeners', 20:25:28 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 20:25:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:28 INFO - 'USER': 'cltbld', 20:25:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:28 INFO - 'XPC_FLAGS': '0x0', 20:25:28 INFO - 'XPC_SERVICE_NAME': '0', 20:25:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:28 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/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0199', '--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 20:25:28 INFO - mozversion application_buildid: 20160221183957 20:25:28 INFO - mozversion application_changeset: 19d4a6ed98e86dcf13fa64be65a8859c9e4dd8f1 20:25:28 INFO - mozversion application_display_name: Nightly 20:25:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:25:28 INFO - mozversion application_name: Firefox 20:25:28 INFO - mozversion application_remotingname: firefox 20:25:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:25:28 INFO - mozversion application_vendor: Mozilla 20:25:28 INFO - mozversion application_version: 47.0a1 20:25:28 INFO - mozversion platform_buildid: 20160221183957 20:25:28 INFO - mozversion platform_changeset: 19d4a6ed98e86dcf13fa64be65a8859c9e4dd8f1 20:25:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:25:28 INFO - mozversion platform_version: 47.0a1 20:25:28 INFO - using testdate: 1456115128 20:25:28 INFO - actual date: 1456115128 20:25:28 INFO - starting webserver on 'localhost:49376' 20:25:28 INFO - SUITE-START | Running 2 tests 20:25:28 INFO - TEST-START | dromaeo_css 20:25:28 INFO - operating with platform_type : mac_ 20:25:28 INFO - Initialising browser for dromaeo_css test... 20:25:28 INFO - TEST-INFO | started process 2119 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpkhZGrp/profile http://localhost:49376/getInfo.html) 20:25:31 INFO - PROCESS | 2119 | __metrics Screen width/height:1600/1200 20:25:31 INFO - PROCESS | 2119 | colorDepth:24 20:25:31 INFO - PROCESS | 2119 | Browser inner width/height: 1024/689 20:25:31 INFO - PROCESS | 2119 | __metrics 20:25:31 INFO - PROCESS | 2119 | 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" 20:25:31 INFO - PROCESS | 2119 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:25:31 INFO - TEST-INFO | 2119: exit 0 20:25:31 INFO - Browser initialized. 20:25:31 INFO - Running cycle 1/1 for dromaeo_css test... 20:25:31 INFO - TEST-INFO | started process 2123 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpkhZGrp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:25:43 INFO - PROCESS | 2123 | RSS: Main: 243040256 20:25:43 INFO - PROCESS | 2123 | 20:26:35 INFO - PROCESS | 2123 | 1456115195007 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] 20:28:45 INFO - PROCESS | 2123 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49376/tests/dromaeo/cssquery-ext.html) 20:28:46 INFO - PROCESS | 2123 | RSS: Main: 344113152 20:28:46 INFO - PROCESS | 2123 | 20:31:49 INFO - PROCESS | 2123 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-ext.html (next: http://localhost:49376/tests/dromaeo/cssquery-jquery.html) 20:31:50 INFO - PROCESS | 2123 | RSS: Main: 381112320 20:31:50 INFO - PROCESS | 2123 | 20:34:52 INFO - PROCESS | 2123 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49376/tests/dromaeo/cssquery-mootools.html) 20:34:52 INFO - PROCESS | 2123 | RSS: Main: 373514240 20:34:52 INFO - PROCESS | 2123 | 20:37:55 INFO - PROCESS | 2123 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49376/tests/dromaeo/cssquery-prototype.html) 20:37:55 INFO - PROCESS | 2123 | RSS: Main: 335093760 20:37:55 INFO - PROCESS | 2123 | 20:40:58 INFO - PROCESS | 2123 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49376/tests/dromaeo/cssquery-yui.html) 20:40:59 INFO - PROCESS | 2123 | RSS: Main: 342081536 20:40:59 INFO - PROCESS | 2123 | 20:44:02 INFO - PROCESS | 2123 | Cycle 1(1): loaded http://localhost:49376/tests/dromaeo/cssquery-yui.html (next: http://localhost:49376/tests/dromaeo/cssquery-dojo.html) 20:44:02 INFO - PROCESS | 2123 | RSS: Main: 424181760 20:44:02 INFO - PROCESS | 2123 | 20:44:02 INFO - PROCESS | 2123 | __start_tp_report 20:44:02 INFO - PROCESS | 2123 | _x_x_mozilla_page_load 20:44:02 INFO - PROCESS | 2123 | _x_x_mozilla_page_load_details 20:44:02 INFO - PROCESS | 2123 | |i|pagename|runs| 20:44:02 INFO - PROCESS | 2123 | |0;dojo.html;3438.931221375572;3493;3508.842102105405;3514.5606799150105;3561.9821900890493;5601.551875849922;5637.3235211774545;5666;5700.05949018412;5723.170140329655;4769.976150119253;5651.180578816069;5731.226284451598;5738.167965644979;5789.913151302723;5108.489151084899;5135.717535535535;5149.99575082859;5178.300929374524;5304.124819404794;5251.422343542207;5265.552428043621;5305.098133317345;5318.521333080022;5368.62419630626;4171.687123465722;5125.897482050356;5198.376194856642;5222.451642577513;5241.109011468022;5216.452272511369;5217.373915130209;5237.633365664405;5243.318368612056;5250.05499010178;5113.028524580318;5153.6907785532985;5175.611829112794;5189.3772747270195;5209.7134657593815;5495.450454954513;5574.024545704486;5590.776368945238;5656.830295091154;5711.257536520226;6209.59637623553;6265.966115590968;6266.624002559861;6275.435210831047;6275.780347687854;6128.509719222496;6250.656213908233;6313.842153946142;6323.051542268697;6328.557001009931;5758.884822303572;5792.652440853562;5804.65172089676;5807.361190269067;5858.853528661775;6295.213098362705;6311.431971122621;6330.145430366933;6331.68341582919;6334.366563343721;5981.581289309794;6089.634621922699;6097.878042439126;6143.354947730513;6187.783427580013;6225.3774622537385;6266.749330026839;6270.996640537492;6272.96496078142;6274.905876411857;6138.14066030756;6181.505479561714;6204.720787564571;6226.533010024266;6244.968775156095;6122.632642041492;6180.289266734293;6182.752689892444;6187.721552530147;6230.252369715663;4837;4854.417469903634;4918.606511479073;4927.7536123193695;4979.601631869442;4387.473503179639;4390.1878152541885;4392.956070439319;4396.3845061690745;4423.491298500714;5665.5184309333345;5753.568482363839;5765.740541675635;5789.189513468118;5789.507891829157;6202.937970620236;6245.18812554365;6291.591046581958;6297;6299.118123462719;5768.971155144198;5779.826605201851;5782.913256301159;5792.420757924258;5832.096025116114;5252.711100889488;5359.517643412111;5407.432219616883;5409.621326507186;5411.323584551931;6434.195725534309;6463.321351258144;6466.870662586816;6466.967665161644;6471.385218404244;6288.339724328879;6293.905591416041;6299.842503937438;6304.243490781136;6311.526635502448;5325.254464374913;6262.561620686508;6432;6435.710393032418;6450.548461607643;6137.202163718688;6208.596441231305;6210.3168651449205;6211.223597050369;6223.564350495421;6132.5707200495535;6277.435030847246;6294.181756371642;6298.685065746603;6301.023341382093;6065.727042283196;6130.092410195535;6139.706800529493;6140.350877193083;6141.51669281436;6114.969425152845;6124.203853499017;6125.356837532173;6127.785527506516;6132.2947860996555;4510.729356238636;5798.246227990334;5905.793297234748;5956.106584012433;6008.849778755566;6089.058056960158;6108.083787431743;6114.266288045463;6133.51829027926;6137.49425608856;5981.820545383645;5985.670788106696;5991.071383935497;6000.819975400745;6019.036954087325 20:44:02 INFO - PROCESS | 2123 | |1;ext.html;449.88527925379043;454.78397761063496;493.2576472409024;536.6243629459375;556.9749361278742;30264.394712105746;38327.041823954416;38967.610323896755;38971.22057558851;38995.61004389955;41567.79216103915;41967.58032419675;41974.37038444426;42073.78963105188;42082.7895860521;9479.952600237006;9712.61149554017;9716.951415242915;9725.416475011487;9728.075832795874;9576.186024187917;9707.805843883118;9721.513924303756;9722.562484688206;9845.507724613777;9797.26520510961;9865.704028879109;9876.802463950717;9883.802323953552;9889.653862114827;9761.902380976171;9825.066618671215;9827;9840.507974601313;9855.457949812757;9516.571754271004;9621.27840411972;9664.178544823628;9668.95165524175;9695.806083878282;40119.39820902689;40480.59519404798;40486.797566012276;40522;40544.594554054376;3114.299282661406;3133.7336326412283;3185.0285662872816;3232.6120865496055;3321.618013928405;28855;29305;29513.704862951312;29536.409271814442;29797.833863077107;2732.49448851963;2754.73829986151;2830.674472435676;2867.3691787806647;2974.0631701014327;496464;497263;500238;500395;501803.4909825464;45474;45767;45821.396251131715;66694;67487.66256168688;35680;44336;44421.77789111034;44424.11151776947;44548.10903781971;15036.473723419847;15163.545093647208;15188.696226075417;15188.860835437386;15208.391664333303;12240.143189976616;12299.323537205539;12299.93850030762;12311.75376492483;12342.321172335607;14582.708345833023;14604.904632152631;14615.78076328856;14630.780538291934;14751.483698070731;5687.914681279784;5724.713764311768;6308.558400911892;6313.2424109107205;6340.397662222082;877.0790669796688;995.2983146881431;1054.9103326217205;1067.7384040910026;1077.6066735641434;29524.756333335117;29878.551821722693;29941.10176694659;29964.250893727396;31416;907.9319051071196;1034.3690348887174;1037.8495118207818;1049.1659130990881;1133.7562424078862;12149.574764883364;14363.56909292723;14675.633109172142;14712.779308310384;16200.837991620168;662543;668204;673483;675001;676248;53061.2040819388;61152.08271875925;62055.689721551105;62130.37869621336;62197.37802621916;1419.3825685826698;1436.2818590704649;1443.08364188743;1446.1395469695515;1553.479584339259;28822;29466.45530935832;29768.553471698375;30154.547681784352;30449.847750761106;49753.751231243616;50669;51131;51197.48802511927;51214.48785512097;511489;514051;514692;515003;516015;28183.859080704464;32169.517457237693;33113.33773324568;33115.66884331126;33134;40991.795041024605;41638;41695.58304416917;42026.36960445534;42861.57138428576;34281.80013699509;35705.28589428145;35710.285794284486;35845.82077089598;38302.233955321295;35690.75082372104;37628;37906.241875162894;38051.80974095112;38980.83057508279;35410.645893540735;36222.63777362193;36510.269794604494;36519.45220821743;36619.63380366162;29721.405571888874;32331;32412.189695257806;32413;32797.34405311833;21242.575148497253;21858.781412185675;23824.332296739754;24636.71962686796;25284.62073068942 20:44:02 INFO - PROCESS | 2123 | |2;jquery.html;366.844091261214;370.7330721880247;371.3167771300806;375.52871146710874;378.38701303887706;15772.44796432125;16375.83624163758;19588;20508;21102.15591376345;14205.928970355133;15606.921965390156;16972.98162110271;20579.691304630443;21350.679739803876;6427.550071494986;6661.200655921272;6668.533202675814;6672;6673.399394054534;4613.815447382118;6580.111684922546;6663.100481435017;6672.833179170511;7300.196978332379;7571.772846814604;7584.241575842427;7597.734079307225;7613.086429628453;7617.542947423145;4872.731999740031;5956.672383018932;5957.463828255434;5972.850678733023;7545.773626791205;5641.605087643867;5688.061469857468;5698.088305871082;5703.629264097862;5703.914441283384;13323.934085273155;13334;13341.466341346335;13363.465461381533;15087.773683394758;2068.834493240537;2176.205684924991;2364.775346342112;2587.90942317018;2743.9451210975667;10161.949190254001;10301.9484902575;11455.31268123907;12833;15337.926345155844;1742.1028170492207;1776.2628509168808;1779.4750548588197;1802;1805.3139806873305;78335;115904.42047789792;116963;117165.41417292944;118056.81943180544;8959.552022398853;11444.427778611036;11572.710682232842;11575.594854180063;11645.6506304811;13989.650258743613;14019.649508762159;14041.85958140426;14052;14064.929675351557;8393.748187554384;8487.405881588353;8503.14968503157;8584.399092063495;8609.397342186112;8554.657813687383;8595.02325396511;8625.741227763177;8659.74020779365;8767;4082.6121518455698;4088.3867419887256;4287.421198138274;4485.215087359699;4536.478304994967;1831.0204040838087;1883.726859605377;1890.5651700108776;1898.8860668359944;1913.3972798568407;740.7518481308714;840.785599672092;898.2409863665192;918.2975024106564;1024.8316918712674;17127;18910.527236818914;19181.80818191828;19539.706904396444;19647.115879785444;933.7712260496222;945.5508633399218;955.7753927826955;969.6460791810938;1001.8998100189923;8292.668293268202;8922.616994365884;9013.63945442188;10956.945215273872;11090.445477726082;607510;618891;628545;631136;634969;117612;120510;122426;123799.38100309442;124177.37911310386;848.7241646465047;929.8419268724333;984;986.6004268271362;987.7283746969497;18973.43079707611;19177.808221917603;19196.232150714375;19272.421827345202;19322.93723845202;50215;51948.44154675366;52299.47700522946;52323.73838130785;52420.47579524309;72949.90575141483;74685.25314747001;74747.87878181941;75816.62091689727;75854;8071.515709057476;8101.230383113595;8315.962589165692;8336.208060234268;8346.374021948499;10807.67576972692;13681.657958551115;13908.721825563229;13912.234827084607;13999.930000349934;11576.189666723249;11773.293602383885;11803.527858885549;11894.286342819458;11934;11405.885941140814;11654.533818647498;11691.298522088702;11832.940835295769;11956.46195921203;5619.100943848965;9919.454430006419;10254.256776348187;11849.822252666389;11949.044076474034;5647.375370587177;8164;8268.586570671563;8376;8487.405881588229;11104.278221915549;11181.608643697431;11851;11989.1008174389;12134.575289864812 20:44:02 INFO - PROCESS | 2123 | |3;mootools.html;1312.9409176587053;1400.5518234165072;1547.1490680125928;1731.2815181699596;1952.7461430014096;8095.838083238339;8722.389432739703;8936.821263574724;8941.91058089419;8945.01604823469;8594.914050859505;8819.426737262074;8828.646854125827;8832.381733278657;8833.07252738463;2079.5217100066993;2195.9011844467036;2444.2178502879087;2452.0927256914965;2476.4428003699204;2505.1882597094536;2523.0664654077923;2524.8485090894515;2529.7723204911554;2530.8734563271855;2461.4707837814867;2500.4249022724784;2500.7874330681825;2501.9249422517355;2502.124256510225;2175.5431359414465;2427.9757202428013;2482.900683972639;2483.615039668854;2486.539990101837;1951.9707204391946;2412.2883749294;2417.395651087228;2427.6965379327585;2439.5852705040184;8844.823103537894;8915.598798054038;8918.598663060178;8922.73231803047;8939.910600893973;5475.151351540518;5636.774529018834;5640.802571909963;5644.57665675076;5657;3692.9630703692887;3724.4413337999245;3822.3693090640013;3834.501514803058;3835.8082095895375;872.3283072034498;1044.9111825494842;1063.5586231713908;1072.785442911413;1106.8727096383939;12220.633380998584;12368.690782730504;12382.81425778614;12427.37863106841;12435.316057616827;4990.126727822689;4996.925046124311;5067.062593420229;5106.795728170906;5112.335396398445;10559.683209503728;10565.207609429324;10574.682759517227;10581.62964296246;10645.680629581126;5062.240663900445;5619.213310136584;5620.1288800236025;5622.297212848394;5630.774769009194;4614.2617181250835;4853.757312134379;4984.27727979441;5057.039162559102;5068.391792984792;3961.9405708914387;3973.443717879499;3976.542697589814;4031.778252196157;4040.34345918178;1314.5004898138645;1314.5004898138645;1318.235423454394;1323.9073264871558;1330.5210124355224;1323.5235315286488;1330.0224335113683;1343.0531475309883;1360.2178747220387;1360.6190266725332;8387.580620968927;8419.49483031008;8423.241908228289;8435;8443.451175673685;506.67572753437827;507.73343994403234;516.5351183934414;518.4582111693289;520.4353276694828;6226.159468471789;6259.061140828821;6272.8118156455375;6284.025975973731;6294.653794041372;10347;10815.026647601597;10860.185486088574;10962.616308429167;10968.670939871816;10464.895351046544;10650.934906509443;10755.40845253503;10769.78460430787;10818.67543973682;8394.580270986426;8454.535000575028;8488.787780305542;8497.107803680648;8502.319814414832;7939.84120317602;8065.153158918464;8074.273315401642;8087.353011759163;8286.792830179294;9551.761205969906;9647.71056868295;9887.901120988698;9897.525618595351;9923.702288931056;10153.989174276267;10198.643047493302;10200.132988696045;10213.540390682585;10422.322549034288;6873.931260687529;7231.16841563227;7666.6166691664075;7681.116671582839;7782.766517004499;8482.703105391281;8512.872306915526;8567.443116197677;8574.742757717278;8601.65593376283;7436.367908727602;7531.736389226351;7601.3918886487845;7658.770236892902;7698.730544430918;7327.194008658937;7387.852242955219;7399.260073992557;7552.093748750185;7576.4317676173405;7955.443118981616;8014.238647328494;8018.959905200437;8019.879701804594;8027.2775450209765;6897.62063086515;7145.1425828900865;7155.821104472429;7165.140183178052;7201.099862517185;7270.163931147986;7271.60006199643;7329.157146928172;7329.157146928172;7353.338199562065 20:44:02 INFO - PROCESS | 2123 | |4;prototype.html;318.110880090148;324.6931649591136;328.5236407209547;328.5252809689998;334.17625553011806;6398.776042838502;6498.220213574372;6575.079488871555;6593.472522198219;6651.667416629161;6390.5207109466855;6529.673516324188;6560.179977502812;6573.375529324719;6607.867842643144;4072.8778136655947;4734.479207287204;4882.340883980671;4887.804487820483;4892.461829198785;4594.540545945412;4742.383490146276;4816.662833601649;4886.48691887352;4890.24201248807;4823.662343635947;4827.56551910328;4829.613630909536;4831.130396528623;4838.540338667838;3933.4689816874643;4858.611311095104;4867.318575399447;4871.342368780205;4884.3406140171155;4126.773027483488;4127.649149822269;4139.627433530966;4144.564820693814;4145.0880806222585;6323.430891219812;6358.872822543523;6378.362163783585;6380.202474690664;6403.551751377406;4402.449693788277;5344.278522399465;5527.55779537636;5655.321361436613;5659.349174844863;6847.520673552854;6898.482613803984;6898.827529311757;6899.896501552481;6901.965490172567;4021.733154056463;4372.300431930876;4485.730856148642;4487.596116349511;4510.323451482271;7159.105111861018;7331.900214967744;7338.926610733878;7342.4860259781835;7353.742619008309;4499.280115181556;4554.294084416854;4567;4578.878174847184;4586.380838586748;4655.323189166243;4656.767161641905;4657.767111644404;4659.603933665609;4660.207764680013;5526.557875369961;5533.612647114664;5535.225068490334;5543.1685247213245;5543.61194716374;6518.706658200393;6716.328367163244;7015.579065256101;7018.8418910880155;7051.29487051301;1306.9934650326877;1588.8252292247844;1618.4173697468902;1619.1256721370328;1623.123513302827;1014.573878970834;1018.2414101494434;1043.1029314789275;1044.1594516414207;1044.2585764107569;6478.578892371981;6522.347765223534;6558.672066396661;6571.868562628816;6579.868402631921;6059.363766804422;7188.424926005907;7218.6390680465765;7220.3140701633265;7233.31283528064;5305.893882122413;6391.456726178327;6454.903176452357;6543.3968677674275;6562.901556476657;3814.4469051987307;3823.7896915669903;3838.9232215355537;3853.094522787143;3854.0557563397147;7194.532355396883;7615.428842836699;7623.542587444771;7632.694692212361;7634.351080158138;7388.482806203514;7447.702091916371;7452.366548843301;7471.626418679044;7485.139208990927;7584.241575842371;7605.923940760632;7610.657520411595;7614.390848732199;7644.464887457824;5824.70876456167;5857.853553661193;6917.273686263071;7199.1001124859395;7201.3518783309755;7095.929040709733;7096.1839388468925;7098.680559374738;7129.893051604334;7149.463790215858;5678.8926159398525;6298.622082675054;7438.020658947437;7605.391568674603;7638.236176382317;4194.769287689084;4291.678124140764;4584.679072464895;4587.853036740815;4590.609798167193;6984.930150698428;7176;7182.3535881770895;7185.2814718527725;7201.171865235356;6870.690818913261;6990.196127445205;7020.859582808417;7026.191987921455;7042.436605071684;6947.895781563179;6953.756618518328;6963.6866341013765;6970.093887794555;6982;6869.553479023847;6872.62200578973;6877.518573699793;6878.7248510059035;6894.345037221456;6697.866042679022;6987.0567473392475;7022.859542809013;7028.434621363063;7062.15254169503;6862.9313706862295;6896.241413444617;6899.896501552581;6902.240753517009;6908.723651054102 20:44:02 INFO - PROCESS | 2123 | |5;yui.html;659.2912618934645;686.8392416815582;732.5641243460143;745.262190431473;756.4629113329536;14819.036762610423;15034.774478382833;15057.924710376461;15074.849251507481;15079.924600376982;12013.459394327254;12877.905378042877;13540;13605.863941360583;13617;673.2627772589032;826.2646244842095;833.4291010657688;850.0988951711175;850.8893843800329;839.5046922315832;850.6894983331101;851.3061854588491;851.3317046118798;855.0466230153365;713.8964850096733;894.8791913091746;895.0557162193883;896.8206358728248;897.5108565831638;883.902770695223;899.2850683706469;901.3465237702678;902.0168016861652;902.4044130873592;665.7303791964263;667.2893368562466;667.4493542827187;668.5520701130255;670.4736781626449;14767.556973290712;14805.925970370079;14822.40710371584;14830.555083347517;14877;11466.770664586746;12904.354782260849;12969.740605187937;13044.217346959213;13420.530281440102;9922.206223502102;10155.492225388774;10159.390436573829;10173.440460774655;10183.439910804902;3507.1232191952013;3600.819959002066;3675.5956844747056;3693.519842420495;3706.629337066299;82840.9999999994;83208.58395708044;86401.56799216027;86888.56555717181;87059;7998.64006119726;9697.224222062217;9706.223502119814;9820.950895245622;9856.950715246378;21539.13843446276;21681.67477487839;21690.24084157047;21732.456688582595;21740.565188696455;7403.85192296151;7405.518641288299;7526.360259377905;7543.8114047148165;7551.471397002267;4012.7792971386853;4092.7748973806133;4098.836046558164;4103.466549348565;4103.671706263492;3457.6369481204615;3488.3720930232803;3506.281212351462;3508.6842184203542;3509.3858574749315;576.9423057694197;656.4256275758711;659.0410952064734;684.3498676257575;685.9828504287433;546.4890327543759;579.0908274009764;584.6755050946765;615.9427512109486;631.5831551176202;8126.268635822805;8272.090070092285;8418.747437576883;8509.149085091442;8524.40329176964;583.3320847629441;599.7421108923205;601.6360102138143;619.2166908860295;623.3486007122568;3335.949960750591;3871.825767840454;3964.5638979712207;3989.9601003989587;4062.8171732272117;97658;97995.51002245086;98505;100361;100692.49653751684;80166;80507.59746201232;80636.19363806286;81089;83043;72590;73081;73575.26424735684;73808;74569;7940.379674707217;7948.583812869132;8100.71647492335;8148.918510814816;8181.100078991187;50913.745431272604;51420.74289628528;51684.74157629338;52283.95432091413;52447.475525244256;58776;60650;64890;66890.33109668842;70418.29581704117;8913.955430222808;10266.794664106825;10302.433366164933;10446.007629275207;10529.999650033542;9462.434080499099;10802.243842931233;11007.83779603794;11447.656570302905;12014.279143251433;10943.343399396063;11054.22620416563;11277;11774.411279436164;12133.69665758363;11221.382823944761;11536.423178841193;11539.88460115388;11647.708807279885;11717.648470545897;11055.502502387573;11145.665630031112;11147.72130696739;11181.72045698864;11191.440427978405;9428.434293942111;9456.763580910532;9649.614015439585;9692.806143876942;9731.610735570497;8827.341022954784;9414.293927955294;9684.903150968401;9703.563339649874;9763 20:44:02 INFO - PROCESS | 2123 | __end_tp_report 20:44:02 INFO - PROCESS | 2123 | __start_cc_report 20:44:02 INFO - PROCESS | 2123 | _x_x_mozilla_cycle_collect,998 20:44:02 INFO - PROCESS | 2123 | __end_cc_report 20:44:02 INFO - PROCESS | 2123 | __startTimestamp1456116242506__endTimestamp 20:44:02 INFO - PROCESS | 2123 | 20:44:02 INFO - PROCESS | 2123 | ------- Summary: start ------- 20:44:02 INFO - PROCESS | 2123 | Number of tests: 6 20:44:02 INFO - PROCESS | 2123 | 20:44:02 INFO - PROCESS | 2123 | [#0] dojo.html Cycles:165 Average:5741.02 Median:5985.67 stddev:658.82 (11.0%) stddev-sans-first:635.60 20:44:02 INFO - PROCESS | 2123 | Values: 3438.9 3493.0 3508.8 3514.6 3562.0 5601.6 5637.3 5666.0 5700.1 5723.2 4770.0 5651.2 5731.2 5738.2 5789.9 5108.5 5135.7 5150.0 5178.3 5304.1 5251.4 5265.6 5305.1 5318.5 5368.6 4171.7 5125.9 5198.4 5222.5 5241.1 5216.5 5217.4 5237.6 5243.3 5250.1 5113.0 5153.7 5175.6 5189.4 5209.7 5495.5 5574.0 5590.8 5656.8 5711.3 6209.6 6266.0 6266.6 6275.4 6275.8 6128.5 6250.7 6313.8 6323.1 6328.6 5758.9 5792.7 5804.7 5807.4 5858.9 6295.2 6311.4 6330.1 6331.7 6334.4 5981.6 6089.6 6097.9 6143.4 6187.8 6225.4 6266.7 6271.0 6273.0 6274.9 6138.1 6181.5 6204.7 6226.5 6245.0 6122.6 6180.3 6182.8 6187.7 6230.3 4837.0 4854.4 4918.6 4927.8 4979.6 4387.5 4390.2 4393.0 4396.4 4423.5 5665.5 5753.6 5765.7 5789.2 5789.5 6202.9 6245.2 6291.6 6297.0 6299.1 5769.0 5779.8 5782.9 5792.4 5832.1 5252.7 5359.5 5407.4 5409.6 5411.3 6434.2 6463.3 6466.9 6467.0 6471.4 6288.3 6293.9 6299.8 6304.2 6311.5 5325.3 6262.6 6432.0 6435.7 6450.5 6137.2 6208.6 6210.3 6211.2 6223.6 6132.6 6277.4 6294.2 6298.7 6301.0 6065.7 6130.1 6139.7 6140.4 6141.5 6115.0 6124.2 6125.4 6127.8 6132.3 4510.7 5798.2 5905.8 5956.1 6008.8 6089.1 6108.1 6114.3 6133.5 6137.5 5981.8 5985.7 5991.1 6000.8 6019.0 20:44:02 INFO - PROCESS | 2123 | 20:44:02 INFO - PROCESS | 2123 | [#1] ext.html Cycles:180 Average:68374.04 Median:38976.03 stddev:151715.95 (389.3%) stddev-sans-first:152055.84 20:44:02 INFO - PROCESS | 2123 | Values: 449.9 454.8 493.3 536.6 557.0 30264.4 38327.0 38967.6 38971.2 38995.6 41567.8 41967.6 41974.4 42073.8 42082.8 9480.0 9712.6 9717.0 9725.4 9728.1 9576.2 9707.8 9721.5 9722.6 9845.5 9797.3 9865.7 9876.8 9883.8 9889.7 9761.9 9825.1 9827.0 9840.5 9855.5 9516.6 9621.3 9664.2 9669.0 9695.8 40119.4 40480.6 40486.8 40522.0 40544.6 3114.3 3133.7 3185.0 3232.6 3321.6 28855.0 29305.0 29513.7 29536.4 29797.8 2732.5 2754.7 2830.7 2867.4 2974.1 496464.0 497263.0 500238.0 500395.0 501803.5 45474.0 45767.0 45821.4 66694.0 67487.7 35680.0 44336.0 44421.8 44424.1 44548.1 15036.5 15163.5 15188.7 15188.9 15208.4 12240.1 12299.3 12299.9 12311.8 12342.3 14582.7 14604.9 14615.8 14630.8 14751.5 5687.9 5724.7 6308.6 6313.2 6340.4 877.1 995.3 1054.9 1067.7 1077.6 29524.8 29878.6 29941.1 29964.3 31416.0 907.9 1034.4 1037.8 1049.2 1133.8 12149.6 14363.6 14675.6 14712.8 16200.8 662543.0 668204.0 673483.0 675001.0 676248.0 53061.2 61152.1 62055.7 62130.4 62197.4 1419.4 1436.3 1443.1 1446.1 1553.5 28822.0 29466.5 29768.6 30154.5 30449.8 49753.8 50669.0 51131.0 51197.5 51214.5 511489.0 514051.0 514692.0 515003.0 516015.0 28183.9 32169.5 33113.3 33115.7 33134.0 40991.8 41638.0 41695.6 42026.4 42861.6 34281.8 35705.3 35710.3 35845.8 38302.2 35690.8 37628.0 37906.2 38051.8 38980.8 35410.6 36222.6 36510.3 36519.5 36619.6 29721.4 32331.0 32412.2 32413.0 32797.3 21242.6 21858.8 23824.3 24636.7 25284.6 20:44:02 INFO - PROCESS | 2123 | 20:44:02 INFO - PROCESS | 2123 | [#2] jquery.html Cycles:180 Average:34837.04 Median:368.79 stddev:103662.21 (28108.8%) stddev-sans-first:103920.69 20:44:02 INFO - PROCESS | 2123 | Values: 366.8 370.7 371.3 375.5 378.4 15772.4 16375.8 19588.0 20508.0 21102.2 14205.9 15606.9 16973.0 20579.7 21350.7 6427.6 6661.2 6668.5 6672.0 6673.4 4613.8 6580.1 6663.1 6672.8 7300.2 7571.8 7584.2 7597.7 7613.1 7617.5 4872.7 5956.7 5957.5 5972.9 7545.8 5641.6 5688.1 5698.1 5703.6 5703.9 13323.9 13334.0 13341.5 13363.5 15087.8 2068.8 2176.2 2364.8 2587.9 2743.9 10161.9 10301.9 11455.3 12833.0 15337.9 1742.1 1776.3 1779.5 1802.0 1805.3 78335.0 115904.4 116963.0 117165.4 118056.8 8959.6 11444.4 11572.7 11575.6 11645.7 13989.7 14019.6 14041.9 14052.0 14064.9 8393.7 8487.4 8503.1 8584.4 8609.4 8554.7 8595.0 8625.7 8659.7 8767.0 4082.6 4088.4 4287.4 4485.2 4536.5 1831.0 1883.7 1890.6 1898.9 1913.4 740.8 840.8 898.2 918.3 1024.8 17127.0 18910.5 19181.8 19539.7 19647.1 933.8 945.6 955.8 969.6 1001.9 8292.7 8922.6 9013.6 10956.9 11090.4 607510.0 618891.0 628545.0 631136.0 634969.0 117612.0 120510.0 122426.0 123799.4 124177.4 848.7 929.8 984.0 986.6 987.7 18973.4 19177.8 19196.2 19272.4 19322.9 50215.0 51948.4 52299.5 52323.7 52420.5 72949.9 74685.3 74747.9 75816.6 75854.0 8071.5 8101.2 8316.0 8336.2 8346.4 10807.7 13681.7 13908.7 13912.2 13999.9 11576.2 11773.3 11803.5 11894.3 11934.0 11405.9 11654.5 11691.3 11832.9 11956.5 5619.1 9919.5 10254.3 11849.8 11949.0 5647.4 8164.0 8268.6 8376.0 8487.4 11104.3 11181.6 11851.0 11989.1 12134.6 20:44:02 INFO - PROCESS | 2123 | 20:44:02 INFO - PROCESS | 2123 | [#3] mootools.html Cycles:180 Average:6176.01 Median:5109.57 stddev:3308.74 (64.8%) stddev-sans-first:3297.83 20:44:02 INFO - PROCESS | 2123 | Values: 1312.9 1400.6 1547.1 1731.3 1952.7 8095.8 8722.4 8936.8 8941.9 8945.0 8594.9 8819.4 8828.6 8832.4 8833.1 2079.5 2195.9 2444.2 2452.1 2476.4 2505.2 2523.1 2524.8 2529.8 2530.9 2461.5 2500.4 2500.8 2501.9 2502.1 2175.5 2428.0 2482.9 2483.6 2486.5 1952.0 2412.3 2417.4 2427.7 2439.6 8844.8 8915.6 8918.6 8922.7 8939.9 5475.2 5636.8 5640.8 5644.6 5657.0 3693.0 3724.4 3822.4 3834.5 3835.8 872.3 1044.9 1063.6 1072.8 1106.9 12220.6 12368.7 12382.8 12427.4 12435.3 4990.1 4996.9 5067.1 5106.8 5112.3 10559.7 10565.2 10574.7 10581.6 10645.7 5062.2 5619.2 5620.1 5622.3 5630.8 4614.3 4853.8 4984.3 5057.0 5068.4 3961.9 3973.4 3976.5 4031.8 4040.3 1314.5 1314.5 1318.2 1323.9 1330.5 1323.5 1330.0 1343.1 1360.2 1360.6 8387.6 8419.5 8423.2 8435.0 8443.5 506.7 507.7 516.5 518.5 520.4 6226.2 6259.1 6272.8 6284.0 6294.7 10347.0 10815.0 10860.2 10962.6 10968.7 10464.9 10650.9 10755.4 10769.8 10818.7 8394.6 8454.5 8488.8 8497.1 8502.3 7939.8 8065.2 8074.3 8087.4 8286.8 9551.8 9647.7 9887.9 9897.5 9923.7 10154.0 10198.6 10200.1 10213.5 10422.3 6873.9 7231.2 7666.6 7681.1 7782.8 8482.7 8512.9 8567.4 8574.7 8601.7 7436.4 7531.7 7601.4 7658.8 7698.7 7327.2 7387.9 7399.3 7552.1 7576.4 7955.4 8014.2 8019.0 8019.9 8027.3 6897.6 7145.1 7155.8 7165.1 7201.1 7270.2 7271.6 7329.2 7329.2 7353.3 20:44:02 INFO - PROCESS | 2123 | 20:44:02 INFO - PROCESS | 2123 | [#4] prototype.html Cycles:180 Average:5670.35 Median:6488.40 stddev:1826.73 (28.2%) stddev-sans-first:1787.14 20:44:02 INFO - PROCESS | 2123 | Values: 318.1 324.7 328.5 328.5 334.2 6398.8 6498.2 6575.1 6593.5 6651.7 6390.5 6529.7 6560.2 6573.4 6607.9 4072.9 4734.5 4882.3 4887.8 4892.5 4594.5 4742.4 4816.7 4886.5 4890.2 4823.7 4827.6 4829.6 4831.1 4838.5 3933.5 4858.6 4867.3 4871.3 4884.3 4126.8 4127.6 4139.6 4144.6 4145.1 6323.4 6358.9 6378.4 6380.2 6403.6 4402.4 5344.3 5527.6 5655.3 5659.3 6847.5 6898.5 6898.8 6899.9 6902.0 4021.7 4372.3 4485.7 4487.6 4510.3 7159.1 7331.9 7338.9 7342.5 7353.7 4499.3 4554.3 4567.0 4578.9 4586.4 4655.3 4656.8 4657.8 4659.6 4660.2 5526.6 5533.6 5535.2 5543.2 5543.6 6518.7 6716.3 7015.6 7018.8 7051.3 1307.0 1588.8 1618.4 1619.1 1623.1 1014.6 1018.2 1043.1 1044.2 1044.3 6478.6 6522.3 6558.7 6571.9 6579.9 6059.4 7188.4 7218.6 7220.3 7233.3 5305.9 6391.5 6454.9 6543.4 6562.9 3814.4 3823.8 3838.9 3853.1 3854.1 7194.5 7615.4 7623.5 7632.7 7634.4 7388.5 7447.7 7452.4 7471.6 7485.1 7584.2 7605.9 7610.7 7614.4 7644.5 5824.7 5857.9 6917.3 7199.1 7201.4 7095.9 7096.2 7098.7 7129.9 7149.5 5678.9 6298.6 7438.0 7605.4 7638.2 4194.8 4291.7 4584.7 4587.9 4590.6 6984.9 7176.0 7182.4 7185.3 7201.2 6870.7 6990.2 7020.9 7026.2 7042.4 6947.9 6953.8 6963.7 6970.1 6982.0 6869.6 6872.6 6877.5 6878.7 6894.3 6697.9 6987.1 7022.9 7028.4 7062.2 6862.9 6896.2 6899.9 6902.2 6908.7 20:44:02 INFO - PROCESS | 2123 | 20:44:02 INFO - PROCESS | 2123 | [#5] yui.html Cycles:180 Average:18661.01 Median:627.47 stddev:26874.34 (4283.0%) stddev-sans-first:26915.73 20:44:02 INFO - PROCESS | 2123 | Values: 659.3 686.8 732.6 745.3 756.5 14819.0 15034.8 15057.9 15074.8 15079.9 12013.5 12877.9 13540.0 13605.9 13617.0 673.3 826.3 833.4 850.1 850.9 839.5 850.7 851.3 851.3 855.0 713.9 894.9 895.1 896.8 897.5 883.9 899.3 901.3 902.0 902.4 665.7 667.3 667.4 668.6 670.5 14767.6 14805.9 14822.4 14830.6 14877.0 11466.8 12904.4 12969.7 13044.2 13420.5 9922.2 10155.5 10159.4 10173.4 10183.4 3507.1 3600.8 3675.6 3693.5 3706.6 82841.0 83208.6 86401.6 86888.6 87059.0 7998.6 9697.2 9706.2 9821.0 9857.0 21539.1 21681.7 21690.2 21732.5 21740.6 7403.9 7405.5 7526.4 7543.8 7551.5 4012.8 4092.8 4098.8 4103.5 4103.7 3457.6 3488.4 3506.3 3508.7 3509.4 576.9 656.4 659.0 684.3 686.0 546.5 579.1 584.7 615.9 631.6 8126.3 8272.1 8418.7 8509.1 8524.4 583.3 599.7 601.6 619.2 623.3 3335.9 3871.8 3964.6 3990.0 4062.8 97658.0 97995.5 98505.0 100361.0 100692.5 80166.0 80507.6 80636.2 81089.0 83043.0 72590.0 73081.0 73575.3 73808.0 74569.0 7940.4 7948.6 8100.7 8148.9 8181.1 50913.7 51420.7 51684.7 52284.0 52447.5 58776.0 60650.0 64890.0 66890.3 70418.3 8914.0 10266.8 10302.4 10446.0 10530.0 9462.4 10802.2 11007.8 11447.7 12014.3 10943.3 11054.2 11277.0 11774.4 12133.7 11221.4 11536.4 11539.9 11647.7 11717.6 11055.5 11145.7 11147.7 11181.7 11191.4 9428.4 9456.8 9649.6 9692.8 9731.6 8827.3 9414.3 9684.9 9703.6 9763.0 20:44:02 INFO - PROCESS | 2123 | -------- Summary: end -------- 20:44:02 INFO - PROCESS | 2123 | 20:44:03 INFO - TEST-INFO | 2123: exit 0 20:44:03 INFO - TEST-OK | dromaeo_css | took 1114330ms 20:44:03 INFO - TEST-START | kraken 20:44:03 INFO - operating with platform_type : mac_ 20:44:03 INFO - Initialising browser for kraken test... 20:44:03 INFO - TEST-INFO | started process 2127 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmprI7Jeo/profile http://localhost:49376/getInfo.html) 20:44:05 INFO - PROCESS | 2127 | __metrics Screen width/height:1600/1200 20:44:05 INFO - PROCESS | 2127 | colorDepth:24 20:44:05 INFO - PROCESS | 2127 | Browser inner width/height: 1024/689 20:44:05 INFO - PROCESS | 2127 | __metrics 20:44:05 INFO - PROCESS | 2127 | 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" 20:44:05 INFO - PROCESS | 2127 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:44:05 INFO - TEST-INFO | 2127: exit 0 20:44:05 INFO - Browser initialized. 20:44:05 INFO - Running cycle 1/1 for kraken test... 20:44:05 INFO - TEST-INFO | started process 2129 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmprI7Jeo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:44:17 INFO - PROCESS | 2129 | RSS: Main: 244076544 20:44:17 INFO - PROCESS | 2129 | 20:44:20 INFO - PROCESS | 2129 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-beat-detection) 20:44:21 INFO - PROCESS | 2129 | RSS: Main: 291954688 20:44:21 INFO - PROCESS | 2129 | 20:44:23 INFO - PROCESS | 2129 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-dft) 20:44:24 INFO - PROCESS | 2129 | RSS: Main: 300609536 20:44:24 INFO - PROCESS | 2129 | 20:44:27 INFO - PROCESS | 2129 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-fft) 20:44:28 INFO - PROCESS | 2129 | RSS: Main: 288407552 20:44:28 INFO - PROCESS | 2129 | 20:44:30 INFO - PROCESS | 2129 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49376/tests/kraken/driver.html?testName=audio-oscillator) 20:44:30 INFO - PROCESS | 2129 | RSS: Main: 291913728 20:44:30 INFO - PROCESS | 2129 | 20:44:33 INFO - PROCESS | 2129 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49376/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:44:33 INFO - PROCESS | 2129 | RSS: Main: 292143104 20:44:33 INFO - PROCESS | 2129 | 20:44:36 INFO - PROCESS | 2129 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49376/tests/kraken/driver.html?testName=imaging-darkroom) 20:44:37 INFO - PROCESS | 2129 | RSS: Main: 290713600 20:44:37 INFO - PROCESS | 2129 | 20:44:40 INFO - PROCESS | 2129 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49376/tests/kraken/driver.html?testName=imaging-desaturate) 20:44:40 INFO - PROCESS | 2129 | RSS: Main: 292380672 20:44:40 INFO - PROCESS | 2129 | 20:44:43 INFO - PROCESS | 2129 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49376/tests/kraken/driver.html?testName=json-parse-financial) 20:44:44 INFO - PROCESS | 2129 | RSS: Main: 292847616 20:44:44 INFO - PROCESS | 2129 | 20:44:45 INFO - PROCESS | 2129 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49376/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:44:46 INFO - PROCESS | 2129 | RSS: Main: 324452352 20:44:46 INFO - PROCESS | 2129 | 20:44:48 INFO - PROCESS | 2129 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:44:48 INFO - PROCESS | 2129 | RSS: Main: 324681728 20:44:48 INFO - PROCESS | 2129 | 20:44:50 INFO - PROCESS | 2129 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:44:51 INFO - PROCESS | 2129 | RSS: Main: 333119488 20:44:51 INFO - PROCESS | 2129 | 20:44:53 INFO - PROCESS | 2129 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:44:54 INFO - PROCESS | 2129 | RSS: Main: 333504512 20:44:54 INFO - PROCESS | 2129 | 20:44:57 INFO - PROCESS | 2129 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:44:57 INFO - PROCESS | 2129 | RSS: Main: 332374016 20:44:57 INFO - PROCESS | 2129 | 20:44:59 INFO - PROCESS | 2129 | Cycle 1(1): loaded http://localhost:49376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49376/tests/kraken/driver.html?testName=ai-astar) 20:44:59 INFO - PROCESS | 2129 | RSS: Main: 393748480 20:44:59 INFO - PROCESS | 2129 | 20:44:59 INFO - PROCESS | 2129 | __start_tp_report 20:44:59 INFO - PROCESS | 2129 | _x_x_mozilla_page_load 20:44:59 INFO - PROCESS | 2129 | _x_x_mozilla_page_load_details 20:44:59 INFO - PROCESS | 2129 | |i|pagename|runs| 20:44:59 INFO - PROCESS | 2129 | |0;ai-astar;109;107;110;108;113;110;118;157;163;109 20:44:59 INFO - PROCESS | 2129 | |1;audio-beat-detection;168;156;148;158;121;148;130;131;192;153 20:44:59 INFO - PROCESS | 2129 | |2;audio-dft;182;180;186;183;181;185;203;194;181;180 20:44:59 INFO - PROCESS | 2129 | |3;audio-fft;78;76;84;79;55;58;59;97;75;53 20:44:59 INFO - PROCESS | 2129 | |4;audio-oscillator;93;94;129;86;119;125;125;78;78;113 20:44:59 INFO - PROCESS | 2129 | |5;imaging-gaussian-blur;87;90;84;90;84;90;83;90;91;139 20:44:59 INFO - PROCESS | 2129 | |6;imaging-darkroom;131;129;93;93;94;93;94;122;147;99 20:44:59 INFO - PROCESS | 2129 | |7;imaging-desaturate;85;82;86;86;84;84;85;86;86;85 20:44:59 INFO - PROCESS | 2129 | |8;json-parse-financial;54;54;54;53;55;54;76;90;84;52 20:44:59 INFO - PROCESS | 2129 | |9;json-stringify-tinderbox;67;74;69;76;69;67;68;67;72;68 20:44:59 INFO - PROCESS | 2129 | |10;stanford-crypto-aes;84;83;83;83;83;82;83;81;83;82 20:44:59 INFO - PROCESS | 2129 | |11;stanford-crypto-ccm;125;131;136;112;124;121;121;132;137;127 20:44:59 INFO - PROCESS | 2129 | |12;stanford-crypto-pbkdf2;141;128;166;177;133;129;139;142;139;139 20:44:59 INFO - PROCESS | 2129 | |13;stanford-crypto-sha256-iterative;65;66;64;67;68;70;79;91;95;78 20:44:59 INFO - PROCESS | 2129 | __end_tp_report 20:44:59 INFO - PROCESS | 2129 | __start_cc_report 20:44:59 INFO - PROCESS | 2129 | _x_x_mozilla_cycle_collect,1151 20:44:59 INFO - PROCESS | 2129 | __end_cc_report 20:44:59 INFO - PROCESS | 2129 | __startTimestamp1456116299740__endTimestamp 20:44:59 INFO - PROCESS | 2129 | 20:44:59 INFO - PROCESS | 2129 | ------- Summary: start ------- 20:44:59 INFO - PROCESS | 2129 | Number of tests: 14 20:44:59 INFO - PROCESS | 2129 | 20:44:59 INFO - PROCESS | 2129 | [#0] ai-astar Cycles:10 Average:120.40 Median:111.50 stddev:21.15 (19.0%) stddev-sans-first:22.02 20:44:59 INFO - PROCESS | 2129 | Values: 109.0 107.0 110.0 108.0 113.0 110.0 118.0 157.0 163.0 109.0 20:44:59 INFO - PROCESS | 2129 | 20:44:59 INFO - PROCESS | 2129 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:154.50 stddev:20.56 (13.3%) stddev-sans-first:20.81 20:44:59 INFO - PROCESS | 2129 | Values: 168.0 156.0 148.0 158.0 121.0 148.0 130.0 131.0 192.0 153.0 20:44:59 INFO - PROCESS | 2129 | 20:44:59 INFO - PROCESS | 2129 | [#2] audio-dft Cycles:10 Average:185.50 Median:184.00 stddev:7.44 (4.0%) stddev-sans-first:7.79 20:44:59 INFO - PROCESS | 2129 | Values: 182.0 180.0 186.0 183.0 181.0 185.0 203.0 194.0 181.0 180.0 20:44:59 INFO - PROCESS | 2129 | 20:44:59 INFO - PROCESS | 2129 | [#3] audio-fft Cycles:10 Average:71.40 Median:77.00 stddev:14.49 (18.8%) stddev-sans-first:15.17 20:44:59 INFO - PROCESS | 2129 | Values: 78.0 76.0 84.0 79.0 55.0 58.0 59.0 97.0 75.0 53.0 20:44:59 INFO - PROCESS | 2129 | 20:44:59 INFO - PROCESS | 2129 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:78.00 stddev:20.30 (26.0%) stddev-sans-first:21.14 20:44:59 INFO - PROCESS | 2129 | Values: 93.0 94.0 129.0 86.0 119.0 125.0 125.0 78.0 78.0 113.0 20:44:59 INFO - PROCESS | 2129 | 20:44:59 INFO - PROCESS | 2129 | [#5] imaging-gaussian-blur Cycles:10 Average:92.80 Median:90.00 stddev:16.51 (18.3%) stddev-sans-first:17.38 20:44:59 INFO - PROCESS | 2129 | Values: 87.0 90.0 84.0 90.0 84.0 90.0 83.0 90.0 91.0 139.0 20:44:59 INFO - PROCESS | 2129 | 20:44:59 INFO - PROCESS | 2129 | [#6] imaging-darkroom Cycles:10 Average:109.50 Median:93.00 stddev:20.58 (22.1%) stddev-sans-first:20.31 20:44:59 INFO - PROCESS | 2129 | Values: 131.0 129.0 93.0 93.0 94.0 93.0 94.0 122.0 147.0 99.0 20:44:59 INFO - PROCESS | 2129 | 20:44:59 INFO - PROCESS | 2129 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.50 stddev:1.29 (1.5%) stddev-sans-first:1.36 20:44:59 INFO - PROCESS | 2129 | Values: 85.0 82.0 86.0 86.0 84.0 84.0 85.0 86.0 86.0 85.0 20:44:59 INFO - PROCESS | 2129 | 20:44:59 INFO - PROCESS | 2129 | [#8] json-parse-financial Cycles:10 Average:62.60 Median:54.50 stddev:14.71 (27.0%) stddev-sans-first:15.27 20:44:59 INFO - PROCESS | 2129 | Values: 54.0 54.0 54.0 53.0 55.0 54.0 76.0 90.0 84.0 52.0 20:44:59 INFO - PROCESS | 2129 | 20:44:59 INFO - PROCESS | 2129 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:69.00 stddev:3.20 (4.6%) stddev-sans-first:3.24 20:44:59 INFO - PROCESS | 2129 | Values: 67.0 74.0 69.0 76.0 69.0 67.0 68.0 67.0 72.0 68.0 20:44:59 INFO - PROCESS | 2129 | 20:44:59 INFO - PROCESS | 2129 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:0.82 (1.0%) stddev-sans-first:0.73 20:44:59 INFO - PROCESS | 2129 | Values: 84.0 83.0 83.0 83.0 83.0 82.0 83.0 81.0 83.0 82.0 20:44:59 INFO - PROCESS | 2129 | 20:44:59 INFO - PROCESS | 2129 | [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:129.00 stddev:7.68 (6.0%) stddev-sans-first:8.12 20:44:59 INFO - PROCESS | 2129 | Values: 125.0 131.0 136.0 112.0 124.0 121.0 121.0 132.0 137.0 127.0 20:44:59 INFO - PROCESS | 2129 | 20:44:59 INFO - PROCESS | 2129 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.30 Median:140.00 stddev:15.84 (11.3%) stddev-sans-first:16.78 20:44:59 INFO - PROCESS | 2129 | Values: 141.0 128.0 166.0 177.0 133.0 129.0 139.0 142.0 139.0 139.0 20:44:59 INFO - PROCESS | 2129 | 20:44:59 INFO - PROCESS | 2129 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:74.00 stddev:11.14 (15.0%) stddev-sans-first:11.29 20:44:59 INFO - PROCESS | 2129 | Values: 65.0 66.0 64.0 67.0 68.0 70.0 79.0 91.0 95.0 78.0 20:44:59 INFO - PROCESS | 2129 | -------- Summary: end -------- 20:44:59 INFO - PROCESS | 2129 | 20:45:00 INFO - TEST-INFO | 2129: exit 0 20:45:00 INFO - TEST-OK | kraken | took 57445ms 20:45:00 INFO - SUITE-END | took 1171s 20:45:00 INFO - Completed test suite (00:19:32) 20:45:00 INFO - Working with test: dromaeo_css 20:45:00 INFO - Generating results file: dromaeo_css 20:45:00 INFO - Working with test: kraken 20:45:00 INFO - Generating results file: kraken 20:45:00 INFO - javascript benchmark 20:45:00 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:45:01 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 20:45:01 INFO - process_Request line: dromaeo_css 7476.33 graph.html#tests=[[72,64,59]] 20:45:01 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:45:01 INFO - process_Request line: kraken 1478.20 graph.html#tests=[[232,64,59]] 20:45:01 INFO - RETURN: dromaeo_css: 7476.33 20:45:01 INFO - RETURN: kraken: 1478.20 20:45:01 INFO - javascript benchmark 20:45:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3438.931221375572, 3493.0, 3508.842102105405, 3514.5606799150105, 3561.9821900890493, 5601.551875849922, 5637.3235211774545, 5666.0, 5700.05949018412, 5723.170140329655, 4769.976150119253, 5651.180578816069, 5731.226284451598, 5738.167965644979, 5789.913151302723, 5108.489151084899, 5135.717535535535, 5149.99575082859, 5178.300929374524, 5304.124819404794, 5251.422343542207, 5265.552428043621, 5305.098133317345, 5318.521333080022, 5368.62419630626, 4171.687123465722, 5125.897482050356, 5198.376194856642, 5222.451642577513, 5241.109011468022, 5216.452272511369, 5217.373915130209, 5237.633365664405, 5243.318368612056, 5250.05499010178, 5113.028524580318, 5153.6907785532985, 5175.611829112794, 5189.3772747270195, 5209.7134657593815, 5495.450454954513, 5574.024545704486, 5590.776368945238, 5656.830295091154, 5711.257536520226, 6209.59637623553, 6265.966115590968, 6266.624002559861, 6275.435210831047, 6275.780347687854, 6128.509719222496, 6250.656213908233, 6313.842153946142, 6323.051542268697, 6328.557001009931, 5758.884822303572, 5792.652440853562, 5804.65172089676, 5807.361190269067, 5858.853528661775, 6295.213098362705, 6311.431971122621, 6330.145430366933, 6331.68341582919, 6334.366563343721, 5981.581289309794, 6089.634621922699, 6097.878042439126, 6143.354947730513, 6187.783427580013, 6225.3774622537385, 6266.749330026839, 6270.996640537492, 6272.96496078142, 6274.905876411857, 6138.14066030756, 6181.505479561714, 6204.720787564571, 6226.533010024266, 6244.968775156095, 6122.632642041492, 6180.289266734293, 6182.752689892444, 6187.721552530147, 6230.252369715663, 4837.0, 4854.417469903634, 4918.606511479073, 4927.7536123193695, 4979.601631869442, 4387.473503179639, 4390.1878152541885, 4392.956070439319, 4396.3845061690745, 4423.491298500714, 5665.5184309333345, 5753.568482363839, 5765.740541675635, 5789.189513468118, 5789.507891829157, 6202.937970620236, 6245.18812554365, 6291.591046581958, 6297.0, 6299.118123462719, 5768.971155144198, 5779.826605201851, 5782.913256301159, 5792.420757924258, 5832.096025116114, 5252.711100889488, 5359.517643412111, 5407.432219616883, 5409.621326507186, 5411.323584551931, 6434.195725534309, 6463.321351258144, 6466.870662586816, 6466.967665161644, 6471.385218404244, 6288.339724328879, 6293.905591416041, 6299.842503937438, 6304.243490781136, 6311.526635502448, 5325.254464374913, 6262.561620686508, 6432.0, 6435.710393032418, 6450.548461607643, 6137.202163718688, 6208.596441231305, 6210.3168651449205, 6211.223597050369, 6223.564350495421, 6132.5707200495535, 6277.435030847246, 6294.181756371642, 6298.685065746603, 6301.023341382093, 6065.727042283196, 6130.092410195535, 6139.706800529493, 6140.350877193083, 6141.51669281436, 6114.969425152845, 6124.203853499017, 6125.356837532173, 6127.785527506516, 6132.2947860996555, 4510.729356238636, 5798.246227990334, 5905.793297234748, 5956.106584012433, 6008.849778755566, 6089.058056960158, 6108.083787431743, 6114.266288045463, 6133.51829027926, 6137.49425608856, 5981.820545383645, 5985.670788106696, 5991.071383935497, 6000.819975400745, 6019.036954087325], "unit": "score", "name": "dojo.html", "value": 5700.135449419523}, {"lowerIsBetter": false, "replicates": [449.88527925379043, 454.78397761063496, 493.2576472409024, 536.6243629459375, 556.9749361278742, 30264.394712105746, 38327.041823954416, 38967.610323896755, 38971.22057558851, 38995.61004389955, 41567.79216103915, 41967.58032419675, 41974.37038444426, 42073.78963105188, 42082.7895860521, 9479.952600237006, 9712.61149554017, 9716.951415242915, 9725.416475011487, 9728.075832795874, 9576.186024187917, 9707.805843883118, 9721.513924303756, 9722.562484688206, 9845.507724613777, 9797.26520510961, 9865.704028879109, 9876.802463950717, 9883.802323953552, 9889.653862114827, 9761.902380976171, 9825.066618671215, 9827.0, 9840.507974601313, 9855.457949812757, 9516.571754271004, 9621.27840411972, 9664.178544823628, 9668.95165524175, 9695.806083878282, 40119.39820902689, 40480.59519404798, 40486.797566012276, 40522.0, 40544.594554054376, 3114.299282661406, 3133.7336326412283, 3185.0285662872816, 3232.6120865496055, 3321.618013928405, 28855.0, 29305.0, 29513.704862951312, 29536.409271814442, 29797.833863077107, 2732.49448851963, 2754.73829986151, 2830.674472435676, 2867.3691787806647, 2974.0631701014327, 496464.0, 497263.0, 500238.0, 500395.0, 501803.4909825464, 45474.0, 45767.0, 45821.396251131715, 66694.0, 67487.66256168688, 35680.0, 44336.0, 44421.77789111034, 44424.11151776947, 44548.10903781971, 15036.473723419847, 15163.545093647208, 15188.696226075417, 15188.860835437386, 15208.391664333303, 12240.143189976616, 12299.323537205539, 12299.93850030762, 12311.75376492483, 12342.321172335607, 14582.708345833023, 14604.904632152631, 14615.78076328856, 14630.780538291934, 14751.483698070731, 5687.914681279784, 5724.713764311768, 6308.558400911892, 6313.2424109107205, 6340.397662222082, 877.0790669796688, 995.2983146881431, 1054.9103326217205, 1067.7384040910026, 1077.6066735641434, 29524.756333335117, 29878.551821722693, 29941.10176694659, 29964.250893727396, 31416.0, 907.9319051071196, 1034.3690348887174, 1037.8495118207818, 1049.1659130990881, 1133.7562424078862, 12149.574764883364, 14363.56909292723, 14675.633109172142, 14712.779308310384, 16200.837991620168, 662543.0, 668204.0, 673483.0, 675001.0, 676248.0, 53061.2040819388, 61152.08271875925, 62055.689721551105, 62130.37869621336, 62197.37802621916, 1419.3825685826698, 1436.2818590704649, 1443.08364188743, 1446.1395469695515, 1553.479584339259, 28822.0, 29466.45530935832, 29768.553471698375, 30154.547681784352, 30449.847750761106, 49753.751231243616, 50669.0, 51131.0, 51197.48802511927, 51214.48785512097, 511489.0, 514051.0, 514692.0, 515003.0, 516015.0, 28183.859080704464, 32169.517457237693, 33113.33773324568, 33115.66884331126, 33134.0, 40991.795041024605, 41638.0, 41695.58304416917, 42026.36960445534, 42861.57138428576, 34281.80013699509, 35705.28589428145, 35710.285794284486, 35845.82077089598, 38302.233955321295, 35690.75082372104, 37628.0, 37906.241875162894, 38051.80974095112, 38980.83057508279, 35410.645893540735, 36222.63777362193, 36510.269794604494, 36519.45220821743, 36619.63380366162, 29721.405571888874, 32331.0, 32412.189695257806, 32413.0, 32797.34405311833, 21242.575148497253, 21858.781412185675, 23824.332296739754, 24636.71962686796, 25284.62073068942], "unit": "score", "name": "ext.html", "value": 19149.403259295457}, {"lowerIsBetter": false, "replicates": [366.844091261214, 370.7330721880247, 371.3167771300806, 375.52871146710874, 378.38701303887706, 15772.44796432125, 16375.83624163758, 19588.0, 20508.0, 21102.15591376345, 14205.928970355133, 15606.921965390156, 16972.98162110271, 20579.691304630443, 21350.679739803876, 6427.550071494986, 6661.200655921272, 6668.533202675814, 6672.0, 6673.399394054534, 4613.815447382118, 6580.111684922546, 6663.100481435017, 6672.833179170511, 7300.196978332379, 7571.772846814604, 7584.241575842427, 7597.734079307225, 7613.086429628453, 7617.542947423145, 4872.731999740031, 5956.672383018932, 5957.463828255434, 5972.850678733023, 7545.773626791205, 5641.605087643867, 5688.061469857468, 5698.088305871082, 5703.629264097862, 5703.914441283384, 13323.934085273155, 13334.0, 13341.466341346335, 13363.465461381533, 15087.773683394758, 2068.834493240537, 2176.205684924991, 2364.775346342112, 2587.90942317018, 2743.9451210975667, 10161.949190254001, 10301.9484902575, 11455.31268123907, 12833.0, 15337.926345155844, 1742.1028170492207, 1776.2628509168808, 1779.4750548588197, 1802.0, 1805.3139806873305, 78335.0, 115904.42047789792, 116963.0, 117165.41417292944, 118056.81943180544, 8959.552022398853, 11444.427778611036, 11572.710682232842, 11575.594854180063, 11645.6506304811, 13989.650258743613, 14019.649508762159, 14041.85958140426, 14052.0, 14064.929675351557, 8393.748187554384, 8487.405881588353, 8503.14968503157, 8584.399092063495, 8609.397342186112, 8554.657813687383, 8595.02325396511, 8625.741227763177, 8659.74020779365, 8767.0, 4082.6121518455698, 4088.3867419887256, 4287.421198138274, 4485.215087359699, 4536.478304994967, 1831.0204040838087, 1883.726859605377, 1890.5651700108776, 1898.8860668359944, 1913.3972798568407, 740.7518481308714, 840.785599672092, 898.2409863665192, 918.2975024106564, 1024.8316918712674, 17127.0, 18910.527236818914, 19181.80818191828, 19539.706904396444, 19647.115879785444, 933.7712260496222, 945.5508633399218, 955.7753927826955, 969.6460791810938, 1001.8998100189923, 8292.668293268202, 8922.616994365884, 9013.63945442188, 10956.945215273872, 11090.445477726082, 607510.0, 618891.0, 628545.0, 631136.0, 634969.0, 117612.0, 120510.0, 122426.0, 123799.38100309442, 124177.37911310386, 848.7241646465047, 929.8419268724333, 984.0, 986.6004268271362, 987.7283746969497, 18973.43079707611, 19177.808221917603, 19196.232150714375, 19272.421827345202, 19322.93723845202, 50215.0, 51948.44154675366, 52299.47700522946, 52323.73838130785, 52420.47579524309, 72949.90575141483, 74685.25314747001, 74747.87878181941, 75816.62091689727, 75854.0, 8071.515709057476, 8101.230383113595, 8315.962589165692, 8336.208060234268, 8346.374021948499, 10807.67576972692, 13681.657958551115, 13908.721825563229, 13912.234827084607, 13999.930000349934, 11576.189666723249, 11773.293602383885, 11803.527858885549, 11894.286342819458, 11934.0, 11405.885941140814, 11654.533818647498, 11691.298522088702, 11832.940835295769, 11956.46195921203, 5619.100943848965, 9919.454430006419, 10254.256776348187, 11849.822252666389, 11949.044076474034, 5647.375370587177, 8164.0, 8268.586570671563, 8376.0, 8487.405881588229, 11104.278221915549, 11181.608643697431, 11851.0, 11989.1008174389, 12134.575289864812], "unit": "score", "name": "jquery.html", "value": 9402.881317971445}, {"lowerIsBetter": false, "replicates": [1312.9409176587053, 1400.5518234165072, 1547.1490680125928, 1731.2815181699596, 1952.7461430014096, 8095.838083238339, 8722.389432739703, 8936.821263574724, 8941.91058089419, 8945.01604823469, 8594.914050859505, 8819.426737262074, 8828.646854125827, 8832.381733278657, 8833.07252738463, 2079.5217100066993, 2195.9011844467036, 2444.2178502879087, 2452.0927256914965, 2476.4428003699204, 2505.1882597094536, 2523.0664654077923, 2524.8485090894515, 2529.7723204911554, 2530.8734563271855, 2461.4707837814867, 2500.4249022724784, 2500.7874330681825, 2501.9249422517355, 2502.124256510225, 2175.5431359414465, 2427.9757202428013, 2482.900683972639, 2483.615039668854, 2486.539990101837, 1951.9707204391946, 2412.2883749294, 2417.395651087228, 2427.6965379327585, 2439.5852705040184, 8844.823103537894, 8915.598798054038, 8918.598663060178, 8922.73231803047, 8939.910600893973, 5475.151351540518, 5636.774529018834, 5640.802571909963, 5644.57665675076, 5657.0, 3692.9630703692887, 3724.4413337999245, 3822.3693090640013, 3834.501514803058, 3835.8082095895375, 872.3283072034498, 1044.9111825494842, 1063.5586231713908, 1072.785442911413, 1106.8727096383939, 12220.633380998584, 12368.690782730504, 12382.81425778614, 12427.37863106841, 12435.316057616827, 4990.126727822689, 4996.925046124311, 5067.062593420229, 5106.795728170906, 5112.335396398445, 10559.683209503728, 10565.207609429324, 10574.682759517227, 10581.62964296246, 10645.680629581126, 5062.240663900445, 5619.213310136584, 5620.1288800236025, 5622.297212848394, 5630.774769009194, 4614.2617181250835, 4853.757312134379, 4984.27727979441, 5057.039162559102, 5068.391792984792, 3961.9405708914387, 3973.443717879499, 3976.542697589814, 4031.778252196157, 4040.34345918178, 1314.5004898138645, 1314.5004898138645, 1318.235423454394, 1323.9073264871558, 1330.5210124355224, 1323.5235315286488, 1330.0224335113683, 1343.0531475309883, 1360.2178747220387, 1360.6190266725332, 8387.580620968927, 8419.49483031008, 8423.241908228289, 8435.0, 8443.451175673685, 506.67572753437827, 507.73343994403234, 516.5351183934414, 518.4582111693289, 520.4353276694828, 6226.159468471789, 6259.061140828821, 6272.8118156455375, 6284.025975973731, 6294.653794041372, 10347.0, 10815.026647601597, 10860.185486088574, 10962.616308429167, 10968.670939871816, 10464.895351046544, 10650.934906509443, 10755.40845253503, 10769.78460430787, 10818.67543973682, 8394.580270986426, 8454.535000575028, 8488.787780305542, 8497.107803680648, 8502.319814414832, 7939.84120317602, 8065.153158918464, 8074.273315401642, 8087.353011759163, 8286.792830179294, 9551.761205969906, 9647.71056868295, 9887.901120988698, 9897.525618595351, 9923.702288931056, 10153.989174276267, 10198.643047493302, 10200.132988696045, 10213.540390682585, 10422.322549034288, 6873.931260687529, 7231.16841563227, 7666.6166691664075, 7681.116671582839, 7782.766517004499, 8482.703105391281, 8512.872306915526, 8567.443116197677, 8574.742757717278, 8601.65593376283, 7436.367908727602, 7531.736389226351, 7601.3918886487845, 7658.770236892902, 7698.730544430918, 7327.194008658937, 7387.852242955219, 7399.260073992557, 7552.093748750185, 7576.4317676173405, 7955.443118981616, 8014.238647328494, 8018.959905200437, 8019.879701804594, 8027.2775450209765, 6897.62063086515, 7145.1425828900865, 7155.821104472429, 7165.140183178052, 7201.099862517185, 7270.163931147986, 7271.60006199643, 7329.157146928172, 7329.157146928172, 7353.338199562065], "unit": "score", "name": "mootools.html", "value": 4917.953742661381}, {"lowerIsBetter": false, "replicates": [318.110880090148, 324.6931649591136, 328.5236407209547, 328.5252809689998, 334.17625553011806, 6398.776042838502, 6498.220213574372, 6575.079488871555, 6593.472522198219, 6651.667416629161, 6390.5207109466855, 6529.673516324188, 6560.179977502812, 6573.375529324719, 6607.867842643144, 4072.8778136655947, 4734.479207287204, 4882.340883980671, 4887.804487820483, 4892.461829198785, 4594.540545945412, 4742.383490146276, 4816.662833601649, 4886.48691887352, 4890.24201248807, 4823.662343635947, 4827.56551910328, 4829.613630909536, 4831.130396528623, 4838.540338667838, 3933.4689816874643, 4858.611311095104, 4867.318575399447, 4871.342368780205, 4884.3406140171155, 4126.773027483488, 4127.649149822269, 4139.627433530966, 4144.564820693814, 4145.0880806222585, 6323.430891219812, 6358.872822543523, 6378.362163783585, 6380.202474690664, 6403.551751377406, 4402.449693788277, 5344.278522399465, 5527.55779537636, 5655.321361436613, 5659.349174844863, 6847.520673552854, 6898.482613803984, 6898.827529311757, 6899.896501552481, 6901.965490172567, 4021.733154056463, 4372.300431930876, 4485.730856148642, 4487.596116349511, 4510.323451482271, 7159.105111861018, 7331.900214967744, 7338.926610733878, 7342.4860259781835, 7353.742619008309, 4499.280115181556, 4554.294084416854, 4567.0, 4578.878174847184, 4586.380838586748, 4655.323189166243, 4656.767161641905, 4657.767111644404, 4659.603933665609, 4660.207764680013, 5526.557875369961, 5533.612647114664, 5535.225068490334, 5543.1685247213245, 5543.61194716374, 6518.706658200393, 6716.328367163244, 7015.579065256101, 7018.8418910880155, 7051.29487051301, 1306.9934650326877, 1588.8252292247844, 1618.4173697468902, 1619.1256721370328, 1623.123513302827, 1014.573878970834, 1018.2414101494434, 1043.1029314789275, 1044.1594516414207, 1044.2585764107569, 6478.578892371981, 6522.347765223534, 6558.672066396661, 6571.868562628816, 6579.868402631921, 6059.363766804422, 7188.424926005907, 7218.6390680465765, 7220.3140701633265, 7233.31283528064, 5305.893882122413, 6391.456726178327, 6454.903176452357, 6543.3968677674275, 6562.901556476657, 3814.4469051987307, 3823.7896915669903, 3838.9232215355537, 3853.094522787143, 3854.0557563397147, 7194.532355396883, 7615.428842836699, 7623.542587444771, 7632.694692212361, 7634.351080158138, 7388.482806203514, 7447.702091916371, 7452.366548843301, 7471.626418679044, 7485.139208990927, 7584.241575842371, 7605.923940760632, 7610.657520411595, 7614.390848732199, 7644.464887457824, 5824.70876456167, 5857.853553661193, 6917.273686263071, 7199.1001124859395, 7201.3518783309755, 7095.929040709733, 7096.1839388468925, 7098.680559374738, 7129.893051604334, 7149.463790215858, 5678.8926159398525, 6298.622082675054, 7438.020658947437, 7605.391568674603, 7638.236176382317, 4194.769287689084, 4291.678124140764, 4584.679072464895, 4587.853036740815, 4590.609798167193, 6984.930150698428, 7176.0, 7182.3535881770895, 7185.2814718527725, 7201.171865235356, 6870.690818913261, 6990.196127445205, 7020.859582808417, 7026.191987921455, 7042.436605071684, 6947.895781563179, 6953.756618518328, 6963.6866341013765, 6970.093887794555, 6982.0, 6869.553479023847, 6872.62200578973, 6877.518573699793, 6878.7248510059035, 6894.345037221456, 6697.866042679022, 6987.0567473392475, 7022.859542809013, 7028.434621363063, 7062.15254169503, 6862.9313706862295, 6896.241413444617, 6899.896501552581, 6902.240753517009, 6908.723651054102], "unit": "score", "name": "prototype.html", "value": 5058.526957654447}, {"lowerIsBetter": false, "replicates": [659.2912618934645, 686.8392416815582, 732.5641243460143, 745.262190431473, 756.4629113329536, 14819.036762610423, 15034.774478382833, 15057.924710376461, 15074.849251507481, 15079.924600376982, 12013.459394327254, 12877.905378042877, 13540.0, 13605.863941360583, 13617.0, 673.2627772589032, 826.2646244842095, 833.4291010657688, 850.0988951711175, 850.8893843800329, 839.5046922315832, 850.6894983331101, 851.3061854588491, 851.3317046118798, 855.0466230153365, 713.8964850096733, 894.8791913091746, 895.0557162193883, 896.8206358728248, 897.5108565831638, 883.902770695223, 899.2850683706469, 901.3465237702678, 902.0168016861652, 902.4044130873592, 665.7303791964263, 667.2893368562466, 667.4493542827187, 668.5520701130255, 670.4736781626449, 14767.556973290712, 14805.925970370079, 14822.40710371584, 14830.555083347517, 14877.0, 11466.770664586746, 12904.354782260849, 12969.740605187937, 13044.217346959213, 13420.530281440102, 9922.206223502102, 10155.492225388774, 10159.390436573829, 10173.440460774655, 10183.439910804902, 3507.1232191952013, 3600.819959002066, 3675.5956844747056, 3693.519842420495, 3706.629337066299, 82840.9999999994, 83208.58395708044, 86401.56799216027, 86888.56555717181, 87059.0, 7998.64006119726, 9697.224222062217, 9706.223502119814, 9820.950895245622, 9856.950715246378, 21539.13843446276, 21681.67477487839, 21690.24084157047, 21732.456688582595, 21740.565188696455, 7403.85192296151, 7405.518641288299, 7526.360259377905, 7543.8114047148165, 7551.471397002267, 4012.7792971386853, 4092.7748973806133, 4098.836046558164, 4103.466549348565, 4103.671706263492, 3457.6369481204615, 3488.3720930232803, 3506.281212351462, 3508.6842184203542, 3509.3858574749315, 576.9423057694197, 656.4256275758711, 659.0410952064734, 684.3498676257575, 685.9828504287433, 546.4890327543759, 579.0908274009764, 584.6755050946765, 615.9427512109486, 631.5831551176202, 8126.268635822805, 8272.090070092285, 8418.747437576883, 8509.149085091442, 8524.40329176964, 583.3320847629441, 599.7421108923205, 601.6360102138143, 619.2166908860295, 623.3486007122568, 3335.949960750591, 3871.825767840454, 3964.5638979712207, 3989.9601003989587, 4062.8171732272117, 97658.0, 97995.51002245086, 98505.0, 100361.0, 100692.49653751684, 80166.0, 80507.59746201232, 80636.19363806286, 81089.0, 83043.0, 72590.0, 73081.0, 73575.26424735684, 73808.0, 74569.0, 7940.379674707217, 7948.583812869132, 8100.71647492335, 8148.918510814816, 8181.100078991187, 50913.745431272604, 51420.74289628528, 51684.74157629338, 52283.95432091413, 52447.475525244256, 58776.0, 60650.0, 64890.0, 66890.33109668842, 70418.29581704117, 8913.955430222808, 10266.794664106825, 10302.433366164933, 10446.007629275207, 10529.999650033542, 9462.434080499099, 10802.243842931233, 11007.83779603794, 11447.656570302905, 12014.279143251433, 10943.343399396063, 11054.22620416563, 11277.0, 11774.411279436164, 12133.69665758363, 11221.382823944761, 11536.423178841193, 11539.88460115388, 11647.708807279885, 11717.648470545897, 11055.502502387573, 11145.665630031112, 11147.72130696739, 11181.72045698864, 11191.440427978405, 9428.434293942111, 9456.763580910532, 9649.614015439585, 9692.806143876942, 9731.610735570497, 8827.341022954784, 9414.293927955294, 9684.903150968401, 9703.563339649874, 9763.0], "unit": "score", "name": "yui.html", "value": 6838.926827455172}], "name": "dromaeo_css", "value": 7476.333566624955}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 107.0, 110.0, 108.0, 113.0, 110.0, 118.0, 157.0, 163.0, 109.0], "unit": "score", "name": "ai-astar", "value": 120.4}, {"lowerIsBetter": true, "replicates": [168.0, 156.0, 148.0, 158.0, 121.0, 148.0, 130.0, 131.0, 192.0, 153.0], "unit": "score", "name": "audio-beat-detection", "value": 150.5}, {"lowerIsBetter": true, "replicates": [182.0, 180.0, 186.0, 183.0, 181.0, 185.0, 203.0, 194.0, 181.0, 180.0], "unit": "score", "name": "audio-dft", "value": 185.5}, {"lowerIsBetter": true, "replicates": [78.0, 76.0, 84.0, 79.0, 55.0, 58.0, 59.0, 97.0, 75.0, 53.0], "unit": "score", "name": "audio-fft", "value": 71.4}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 129.0, 86.0, 119.0, 125.0, 125.0, 78.0, 78.0, 113.0], "unit": "score", "name": "audio-oscillator", "value": 104.0}, {"lowerIsBetter": true, "replicates": [87.0, 90.0, 84.0, 90.0, 84.0, 90.0, 83.0, 90.0, 91.0, 139.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.8}, {"lowerIsBetter": true, "replicates": [131.0, 129.0, 93.0, 93.0, 94.0, 93.0, 94.0, 122.0, 147.0, 99.0], "unit": "score", "name": "imaging-darkroom", "value": 109.5}, {"lowerIsBetter": true, "replicates": [85.0, 82.0, 86.0, 86.0, 84.0, 84.0, 85.0, 86.0, 86.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 84.9}, {"lowerIsBetter": true, "replicates": [54.0, 54.0, 54.0, 53.0, 55.0, 54.0, 76.0, 90.0, 84.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 62.6}, {"lowerIsBetter": true, "replicates": [67.0, 74.0, 69.0, 76.0, 69.0, 67.0, 68.0, 67.0, 72.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.7}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 83.0, 83.0, 83.0, 82.0, 83.0, 81.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [125.0, 131.0, 136.0, 112.0, 124.0, 121.0, 121.0, 132.0, 137.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.6}, {"lowerIsBetter": true, "replicates": [141.0, 128.0, 166.0, 177.0, 133.0, 129.0, 139.0, 142.0, 139.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.3}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 64.0, 67.0, 68.0, 70.0, 79.0, 91.0, 95.0, 78.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 74.3}], "name": "kraken", "value": 1478.1999999999998}]} 20:45:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1478.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7476.33"}}} 20:45:01 INFO - Return code: 0 20:45:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:45:01 INFO - # TBPL SUCCESS # 20:45:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:45:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:45:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:45:01 INFO - 2016-02-21 20:45:01.457 screenresolution[2133:16743] starting screenresolution argv=screenresolution get 20:45:01 INFO - 2016-02-21 20:45:01.460 screenresolution[2133:16743] Display 0: 1600x1200x32@60 20:45:01 INFO - 2016-02-21 20:45:01.466 screenresolution[2134:16747] starting screenresolution argv=screenresolution list 20:45:01 INFO - Available Modes on Display 0 20:45:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:45:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:45:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:45:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:45:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:45:01 INFO - Intel Iris: 20:45:01 INFO - Chipset Model: Intel Iris 20:45:01 INFO - Type: GPU 20:45:01 INFO - Bus: Built-In 20:45:01 INFO - VRAM (Dynamic, Max): 1536 MB 20:45:01 INFO - Vendor: Intel (0x8086) 20:45:01 INFO - Device ID: 0x0a2e 20:45:01 INFO - Revision ID: 0x0009 20:45:01 INFO - Displays: 20:45:01 INFO - Display: 20:45:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:45:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:45:01 INFO - Display Serial Number: 1600x1200 60 20:45:01 INFO - Main Display: Yes 20:45:01 INFO - Mirror: Off 20:45:01 INFO - Online: Yes 20:45:01 INFO - Rotation: Supported 20:45:01 INFO - Return code: 0 20:45:01 INFO - Running post-action listener: _resource_record_post_action 20:45:01 INFO - Running post-run listener: _resource_record_post_run 20:45:02 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 30969344; Write bytes: 704687616; Read time: 321; Write time: 1838 20:45:02 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 403415552; Write bytes: 397370880; Read time: 30442; Write time: 678 20:45:02 INFO - run-tests - Wall time: 1175s; CPU: 52.0%; Read bytes: 30944768; Write bytes: 297846784; Read time: 320; Write time: 1127 20:45:02 INFO - Running post-run listener: _upload_blobber_files 20:45:02 INFO - Blob upload gear active. 20:45:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:45:02 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 20:45:02 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'] 20:45:02 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 20:45:03 INFO - (blobuploader) - INFO - Open directory for files ... 20:45:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:45:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:45:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:45:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:45:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:45:04 INFO - (blobuploader) - INFO - Done attempting. 20:45:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:45:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:45:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:45:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:45:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:45:05 INFO - (blobuploader) - INFO - Done attempting. 20:45:05 INFO - (blobuploader) - INFO - Iteration through files over. 20:45:05 INFO - Return code: 0 20:45:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:45:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:45:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/009236dc6a04976b195d19762b6298523ebd33d8459b1c4996abfc0881b40500c8f3142c2dafaf8e109c131517767e700157f7a30a2b86e44a9307a0bc566885", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05ac1261addaa111dafbb7855cd8959bdbf378cbf0a01a031c8bbad67d26a52bbe3150525576468cf54f1b4f3635480e2813865b66ac6b5953463b76de08b3e6"} 20:45:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:45:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:45:05 INFO - Contents: 20:45:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/009236dc6a04976b195d19762b6298523ebd33d8459b1c4996abfc0881b40500c8f3142c2dafaf8e109c131517767e700157f7a30a2b86e44a9307a0bc566885", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05ac1261addaa111dafbb7855cd8959bdbf378cbf0a01a031c8bbad67d26a52bbe3150525576468cf54f1b4f3635480e2813865b66ac6b5953463b76de08b3e6"} 20:45:05 INFO - Running post-run listener: copy_logs_to_upload_dir 20:45:05 INFO - Copying logs to upload dir... 20:45:05 INFO - mkdir: /builds/slave/test/build/upload/logs 20:45:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.073714 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-02-21 20:45:05.216592) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-21 20:45:05.220633) ========= 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.lZss8iCQqU/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.N9rQmC0pHf/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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/009236dc6a04976b195d19762b6298523ebd33d8459b1c4996abfc0881b40500c8f3142c2dafaf8e109c131517767e700157f7a30a2b86e44a9307a0bc566885", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05ac1261addaa111dafbb7855cd8959bdbf378cbf0a01a031c8bbad67d26a52bbe3150525576468cf54f1b4f3635480e2813865b66ac6b5953463b76de08b3e6"} build_url:https://queue.taskcluster.net/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010913 build_url: 'https://queue.taskcluster.net/v1/task/ePj6JD5IS0KgMG6SIo4QJQ/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/009236dc6a04976b195d19762b6298523ebd33d8459b1c4996abfc0881b40500c8f3142c2dafaf8e109c131517767e700157f7a30a2b86e44a9307a0bc566885", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05ac1261addaa111dafbb7855cd8959bdbf378cbf0a01a031c8bbad67d26a52bbe3150525576468cf54f1b4f3635480e2813865b66ac6b5953463b76de08b3e6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-21 20:45:05.250490) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 20:45:05.250890) ========= 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.lZss8iCQqU/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.N9rQmC0pHf/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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.005165 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 20:45:05.303628) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-21 20:45:05.304021) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-21 20:45:05.304517) ========= ========= Total master_lag: 0.48 =========