builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0117 starttime: 1455120523.81 results: success (0) buildid: 20160210063321 builduid: 1573e191fb9c48a499f452846a3a0cf9 revision: 6e66d7b4e9572fc86037401b618408d2a58b3c25 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 08:08:43.811438) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 08:08:43.811885) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 08:08:43.812175) ========= 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.rZvIbX0oOt/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.gIQ5wWsKDC/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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.005535 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 08:08:43.833337) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 08:08:43.833629) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 08:08:43.849319) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 08:08:43.849764) ========= 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.rZvIbX0oOt/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.gIQ5wWsKDC/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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.005311 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 08:08:43.898216) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 08:08:43.898528) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 08:08:43.898894) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 08:08:43.899174) ========= 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.rZvIbX0oOt/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.gIQ5wWsKDC/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-10 08:08:44-- 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% 48.0M=0s 2016-02-10 08:08:44 (48.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111308 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 08:08:44.024990) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 08:08:44.025293) ========= 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.rZvIbX0oOt/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.gIQ5wWsKDC/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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.020350 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 08:08:44.158540) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-10 08:08:44.158887) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6e66d7b4e9572fc86037401b618408d2a58b3c25 --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 6e66d7b4e9572fc86037401b618408d2a58b3c25 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rZvIbX0oOt/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.gIQ5wWsKDC/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-10 08:08:44,423 truncating revision to first 12 chars 2016-02-10 08:08:44,424 Setting DEBUG logging. 2016-02-10 08:08:44,424 attempt 1/10 2016-02-10 08:08:44,424 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6e66d7b4e957?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-10 08:08:45,467 unpacking tar archive at: fx-team-6e66d7b4e957/testing/mozharness/ program finished with exit code 0 elapsedTime=1.289564 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-10 08:08:45.464015) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 08:08:45.464382) ========= echo 6e66d7b4e9572fc86037401b618408d2a58b3c25 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6e66d7b4e9572fc86037401b618408d2a58b3c25'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rZvIbX0oOt/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.gIQ5wWsKDC/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 6e66d7b4e9572fc86037401b618408d2a58b3c25 program finished with exit code 0 elapsedTime=0.005674 script_repo_revision: '6e66d7b4e9572fc86037401b618408d2a58b3c25' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 08:08:45.514063) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 08:08:45.514357) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 08:08:45.527500) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-10 08:08:45.527834) ========= /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.rZvIbX0oOt/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.gIQ5wWsKDC/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 08:08:45 INFO - MultiFileLogger online at 20160210 08:08:45 in /builds/slave/test 08:08:45 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 08:08:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:08:45 INFO - {'append_to_log': False, 08:08:45 INFO - 'base_work_dir': '/builds/slave/test', 08:08:45 INFO - 'blob_upload_branch': 'Fx-Team', 08:08:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:08:45 INFO - 'branch': 'Fx-Team', 08:08:45 INFO - 'buildbot_json_path': 'buildprops.json', 08:08:45 INFO - 'config_files': ('talos/mac_config.py',), 08:08:45 INFO - 'default_actions': ('clobber', 08:08:45 INFO - 'read-buildbot-config', 08:08:45 INFO - 'download-and-extract', 08:08:45 INFO - 'populate-webroot', 08:08:45 INFO - 'create-virtualenv', 08:08:45 INFO - 'install', 08:08:45 INFO - 'run-tests'), 08:08:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:08:45 INFO - 'download_minidump_stackwalk': True, 08:08:45 INFO - 'download_symbols': 'ondemand', 08:08:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:08:45 INFO - 'tooltool.py': '/tools/tooltool.py', 08:08:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:08:45 INFO - '/tools/misc-python/virtualenv.py')}, 08:08:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:08:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:08:45 INFO - 'installer_path': 'installer.exe', 08:08:45 INFO - 'log_level': 'info', 08:08:45 INFO - 'log_name': 'talos', 08:08:45 INFO - 'log_to_console': True, 08:08:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:08:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:08:45 INFO - 'opt_config_files': (), 08:08:45 INFO - 'pip_index': False, 08:08:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:08:45 INFO - 'cmd': ('bash', 08:08:45 INFO - '-c', 08:08:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:08:45 INFO - 'enabled': True, 08:08:45 INFO - 'halt_on_failure': False, 08:08:45 INFO - 'name': 'check_screen_resolution'},), 08:08:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:08:45 INFO - 'cmd': ('bash', 08:08:45 INFO - '-c', 08:08:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:08:45 INFO - 'enabled': True, 08:08:45 INFO - 'halt_on_failure': False, 08:08:45 INFO - 'name': 'check_screen_resolution'},), 08:08:45 INFO - 'run_cmd_checks_enabled': True, 08:08:45 INFO - 'sps_profile': False, 08:08:45 INFO - 'sps_profile_interval': 0, 08:08:45 INFO - 'suite': 'dromaeojs', 08:08:45 INFO - 'system_bits': '32', 08:08:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:08:45 INFO - 'title': 't-yosemite-r7-0117', 08:08:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:08:45 INFO - 'use_talos_json': True, 08:08:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:08:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:08:45 INFO - 'work_dir': 'build'} 08:08:45 INFO - ##### 08:08:45 INFO - ##### Running clobber step. 08:08:45 INFO - ##### 08:08:45 INFO - Running pre-action listener: _resource_record_pre_action 08:08:45 INFO - Running main action method: clobber 08:08:45 INFO - rmtree: /builds/slave/test/build 08:08:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:08:46 INFO - Running post-action listener: _resource_record_post_action 08:08:46 INFO - ##### 08:08:46 INFO - ##### Running read-buildbot-config step. 08:08:46 INFO - ##### 08:08:46 INFO - Running pre-action listener: _resource_record_pre_action 08:08:46 INFO - Running main action method: read_buildbot_config 08:08:46 INFO - Using buildbot properties: 08:08:46 INFO - { 08:08:46 INFO - "project": "", 08:08:46 INFO - "product": "firefox", 08:08:46 INFO - "script_repo_revision": "production", 08:08:46 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 08:08:46 INFO - "repository": "", 08:08:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 08:08:46 INFO - "buildid": "20160210063321", 08:08:46 INFO - "pgo_build": "False", 08:08:46 INFO - "basedir": "/builds/slave/test", 08:08:46 INFO - "buildnumber": 320, 08:08:46 INFO - "slavename": "t-yosemite-r7-0117", 08:08:46 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:08:46 INFO - "platform": "yosemite_r7", 08:08:46 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:08:46 INFO - "branch": "fx-team", 08:08:46 INFO - "repo_path": "integration/fx-team", 08:08:46 INFO - "revision": "6e66d7b4e9572fc86037401b618408d2a58b3c25", 08:08:46 INFO - "stage_platform": "macosx64", 08:08:46 INFO - "builduid": "1573e191fb9c48a499f452846a3a0cf9", 08:08:46 INFO - "slavebuilddir": "test" 08:08:46 INFO - } 08:08:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 08:08:46 INFO - Running post-action listener: _resource_record_post_action 08:08:46 INFO - ##### 08:08:46 INFO - ##### Running download-and-extract step. 08:08:46 INFO - ##### 08:08:46 INFO - Running pre-action listener: _resource_record_pre_action 08:08:46 INFO - Running main action method: download_and_extract 08:08:46 INFO - mkdir: /builds/slave/test/build/tests 08:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:46 INFO - https://queue.taskcluster.net/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:08:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/test_packages.json 08:08:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/test_packages.json 08:08:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:08:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:08:47 INFO - Downloaded 1277 bytes. 08:08:47 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:08:47 INFO - Using the following test package requirements: 08:08:47 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:08:47 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:08:47 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 08:08:47 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:08:47 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 08:08:47 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:08:47 INFO - u'jsshell-mac.zip'], 08:08:47 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:08:47 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 08:08:47 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:08:47 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:08:47 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 08:08:47 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:08:47 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 08:08:47 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:08:47 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 08:08:47 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:08:47 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:08:47 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 08:08:47 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:47 INFO - https://queue.taskcluster.net/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:08:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:08:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:08:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/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 08:08:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/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 08:08:48 INFO - Downloaded 17750511 bytes. 08:08:48 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'] 08:08:48 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 08:08:51 INFO - Return code: 0 08:08:51 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 08:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:51 INFO - https://queue.taskcluster.net/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:08:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:08:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:08:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/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 08:08:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/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 08:08:52 INFO - Downloaded 17750511 bytes. 08:08:52 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'] 08:08:52 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 08:08:56 INFO - Return code: 0 08:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:56 INFO - https://queue.taskcluster.net/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:08:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 08:08:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 08:08:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/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 08:08:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/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 08:08:57 INFO - Downloaded 10706547 bytes. 08:08:57 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'] 08:08:57 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 08:08:58 INFO - Return code: 0 08:08: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')]} 08:08:58 INFO - https://queue.taskcluster.net/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:08:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:08:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:08:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 08:08:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/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 08:09:00 INFO - Downloaded 111186583 bytes. 08:09:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:09:00 INFO - mkdir: /builds/slave/test/properties 08:09:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:09:00 INFO - Writing to file /builds/slave/test/properties/build_url 08:09:00 INFO - Contents: 08:09:00 INFO - build_url:https://queue.taskcluster.net/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:09:02 INFO - Running post-action listener: _resource_record_post_action 08:09:02 INFO - Running post-action listener: set_extra_try_arguments 08:09:02 INFO - ##### 08:09:02 INFO - ##### Running populate-webroot step. 08:09:02 INFO - ##### 08:09:02 INFO - Running pre-action listener: _resource_record_pre_action 08:09:02 INFO - Running main action method: populate_webroot 08:09:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:09:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:09:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:09:02 INFO - '--tppagecycles', 08:09:02 INFO - '7'], 08:09:02 INFO - 'tests': ['tsvgm']}}, 08:09:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:09:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:09:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:09:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:09:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:09:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:09:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:02 INFO - 'talos_options': ['--e10s'], 08:09:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:02 INFO - 'tests': ['damp', 'tps']}, 08:09:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:02 INFO - 'talos_options': ['--e10s'], 08:09:02 INFO - 'tests': ['damp', 'tps']}, 08:09:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:09:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:09:02 INFO - 'other': {'tests': ['a11yr', 08:09:02 INFO - 'ts_paint', 08:09:02 INFO - 'tpaint', 08:09:02 INFO - 'sessionrestore', 08:09:02 INFO - 'sessionrestore_no_auto_restore']}, 08:09:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:09:02 INFO - 'tests': ['a11yr', 08:09:02 INFO - 'ts_paint', 08:09:02 INFO - 'tpaint', 08:09:02 INFO - 'sessionrestore', 08:09:02 INFO - 'sessionrestore_no_auto_restore']}, 08:09:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:09:02 INFO - 'tests': ['a11yr', 08:09:02 INFO - 'ts_paint', 08:09:02 INFO - 'tpaint', 08:09:02 INFO - 'sessionrestore', 08:09:02 INFO - 'sessionrestore_no_auto_restore']}, 08:09:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:09:02 INFO - 'tests': ['a11yr', 08:09:02 INFO - 'ts_paint', 08:09:02 INFO - 'tpaint', 08:09:02 INFO - 'sessionrestore', 08:09:02 INFO - 'sessionrestore_no_auto_restore']}, 08:09:02 INFO - 'other_l64': {'tests': ['a11yr', 08:09:02 INFO - 'ts_paint', 08:09:02 INFO - 'tpaint', 08:09:02 INFO - 'sessionrestore', 08:09:02 INFO - 'sessionrestore_no_auto_restore']}, 08:09:02 INFO - 'other_nol64': {'tests': ['a11yr', 08:09:02 INFO - 'ts_paint', 08:09:02 INFO - 'tpaint', 08:09:02 INFO - 'sessionrestore', 08:09:02 INFO - 'sessionrestore_no_auto_restore']}, 08:09:02 INFO - 'svgr': {'tests': ['tsvgx', 08:09:02 INFO - 'tsvgr_opacity', 08:09:02 INFO - 'tart', 08:09:02 INFO - 'tscrollx', 08:09:02 INFO - 'cart']}, 08:09:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:09:02 INFO - 'tests': ['tsvgx', 08:09:02 INFO - 'tsvgr_opacity', 08:09:02 INFO - 'tart', 08:09:02 INFO - 'tscrollx', 08:09:02 INFO - 'cart']}, 08:09:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:02 INFO - 'tests': ['tp5o']}, 08:09:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:02 INFO - 'talos_options': ['--e10s'], 08:09:02 INFO - 'tests': ['tp5o']}, 08:09:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:02 INFO - 'talos_options': ['--xperf_path', 08:09:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:02 INFO - 'tests': ['tp5n']}, 08:09:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:02 INFO - 'talos_options': ['--e10s', 08:09:02 INFO - '--xperf_path', 08:09:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:02 INFO - 'tests': ['tp5n']}}, 08:09:02 INFO - 'talos.zip': {'path': '', 08:09:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:09:02 INFO - Running post-action listener: _resource_record_post_action 08:09:02 INFO - ##### 08:09:02 INFO - ##### Running create-virtualenv step. 08:09:02 INFO - ##### 08:09:02 INFO - Running pre-action listener: _resource_record_pre_action 08:09:02 INFO - Running main action method: create_virtualenv 08:09:02 INFO - Creating virtualenv /builds/slave/test/build/venv 08:09:02 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 08:09:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:09:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:09:02 INFO - Using real prefix '/tools/python27' 08:09:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:09:02 INFO - Installing distribute.............................................................................................................................................................................................done. 08:09:05 INFO - Installing pip.................done. 08:09:05 INFO - Return code: 0 08:09:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:05 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 0x101fc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fcb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6dae00fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e67d30>, '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 0x101c8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e5eb20>, '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.rZvIbX0oOt/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.gIQ5wWsKDC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 08:09:05 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 08:09:05 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 08:09:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rZvIbX0oOt/Render', 08:09:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:05 INFO - 'HOME': '/Users/cltbld', 08:09:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:05 INFO - 'LOGNAME': 'cltbld', 08:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:05 INFO - 'MOZ_NO_REMOTE': '1', 08:09:05 INFO - 'NO_EM_RESTART': '1', 08:09:05 INFO - 'PAGER': '/bin/cat', 08:09:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:05 INFO - 'PWD': '/builds/slave/test', 08:09:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:05 INFO - 'SHELL': '/bin/bash', 08:09:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIQ5wWsKDC/Listeners', 08:09:05 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 08:09:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:05 INFO - 'USER': 'cltbld', 08:09:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:05 INFO - 'XPC_FLAGS': '0x0', 08:09:05 INFO - 'XPC_SERVICE_NAME': '0', 08:09:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:06 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 08:09:06 INFO - Cleaning up... 08:09:06 INFO - Return code: 0 08:09:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101fc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fcb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6dae00fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e67d30>, '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 0x101c8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e5eb20>, '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.rZvIbX0oOt/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.gIQ5wWsKDC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 08:09:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:09:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:09:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rZvIbX0oOt/Render', 08:09:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:06 INFO - 'HOME': '/Users/cltbld', 08:09:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:06 INFO - 'LOGNAME': 'cltbld', 08:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:06 INFO - 'MOZ_NO_REMOTE': '1', 08:09:06 INFO - 'NO_EM_RESTART': '1', 08:09:06 INFO - 'PAGER': '/bin/cat', 08:09:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:06 INFO - 'PWD': '/builds/slave/test', 08:09:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:06 INFO - 'SHELL': '/bin/bash', 08:09:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIQ5wWsKDC/Listeners', 08:09:06 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 08:09:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:06 INFO - 'USER': 'cltbld', 08:09:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:06 INFO - 'XPC_FLAGS': '0x0', 08:09:06 INFO - 'XPC_SERVICE_NAME': '0', 08:09:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:06 INFO - Downloading/unpacking psutil>=0.7.1 08:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:09:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:08 INFO - Installing collected packages: psutil 08:09:08 INFO - Running setup.py install for psutil 08:09:08 INFO - building 'psutil._psutil_osx' extension 08:09:08 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 08:09:09 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 08:09:09 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 08:09:09 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 08:09:09 INFO - building 'psutil._psutil_posix' extension 08:09:09 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 08:09:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:09:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:09:09 INFO - ^ 08:09:09 INFO - 1 warning generated. 08:09:09 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 08:09:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:09 INFO - Successfully installed psutil 08:09:09 INFO - Cleaning up... 08:09:09 INFO - Return code: 0 08:09:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101fc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fcb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6dae00fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e67d30>, '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 0x101c8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e5eb20>, '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.rZvIbX0oOt/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.gIQ5wWsKDC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 08:09:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:09:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rZvIbX0oOt/Render', 08:09:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:09 INFO - 'HOME': '/Users/cltbld', 08:09:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:09 INFO - 'LOGNAME': 'cltbld', 08:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:09 INFO - 'MOZ_NO_REMOTE': '1', 08:09:09 INFO - 'NO_EM_RESTART': '1', 08:09:09 INFO - 'PAGER': '/bin/cat', 08:09:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:09 INFO - 'PWD': '/builds/slave/test', 08:09:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:09 INFO - 'SHELL': '/bin/bash', 08:09:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIQ5wWsKDC/Listeners', 08:09:09 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 08:09:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:09 INFO - 'USER': 'cltbld', 08:09:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:09 INFO - 'XPC_FLAGS': '0x0', 08:09:09 INFO - 'XPC_SERVICE_NAME': '0', 08:09:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:09:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:09:12 INFO - Installing collected packages: mozsystemmonitor 08:09:12 INFO - Running setup.py install for mozsystemmonitor 08:09:12 INFO - Successfully installed mozsystemmonitor 08:09:12 INFO - Cleaning up... 08:09:12 INFO - Return code: 0 08:09:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:09: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')]} 08:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09: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')]} 08:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101fc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fcb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6dae00fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e67d30>, '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 0x101c8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e5eb20>, '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.rZvIbX0oOt/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.gIQ5wWsKDC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 08:09:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:09:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rZvIbX0oOt/Render', 08:09:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:12 INFO - 'HOME': '/Users/cltbld', 08:09:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:12 INFO - 'LOGNAME': 'cltbld', 08:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:12 INFO - 'MOZ_NO_REMOTE': '1', 08:09:12 INFO - 'NO_EM_RESTART': '1', 08:09:12 INFO - 'PAGER': '/bin/cat', 08:09:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:12 INFO - 'PWD': '/builds/slave/test', 08:09:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:12 INFO - 'SHELL': '/bin/bash', 08:09:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIQ5wWsKDC/Listeners', 08:09:12 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 08:09:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:12 INFO - 'USER': 'cltbld', 08:09:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:12 INFO - 'XPC_FLAGS': '0x0', 08:09:12 INFO - 'XPC_SERVICE_NAME': '0', 08:09:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:12 INFO - Downloading/unpacking blobuploader==1.2.4 08:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:14 INFO - Downloading blobuploader-1.2.4.tar.gz 08:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:09:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:09:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:16 INFO - Downloading docopt-0.6.1.tar.gz 08:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:09:16 INFO - Installing collected packages: blobuploader, requests, docopt 08:09:16 INFO - Running setup.py install for blobuploader 08:09:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:09:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:09:16 INFO - Running setup.py install for requests 08:09:16 INFO - Running setup.py install for docopt 08:09:17 INFO - Successfully installed blobuploader requests docopt 08:09:17 INFO - Cleaning up... 08:09:17 INFO - Return code: 0 08:09:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:17 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 0x101fc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fcb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6dae00fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e67d30>, '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 0x101c8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e5eb20>, '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.rZvIbX0oOt/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.gIQ5wWsKDC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 08:09:17 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 08:09:17 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 08:09:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rZvIbX0oOt/Render', 08:09:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:17 INFO - 'HOME': '/Users/cltbld', 08:09:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:17 INFO - 'LOGNAME': 'cltbld', 08:09:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:17 INFO - 'MOZ_NO_REMOTE': '1', 08:09:17 INFO - 'NO_EM_RESTART': '1', 08:09:17 INFO - 'PAGER': '/bin/cat', 08:09:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:17 INFO - 'PWD': '/builds/slave/test', 08:09:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:17 INFO - 'SHELL': '/bin/bash', 08:09:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIQ5wWsKDC/Listeners', 08:09:17 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 08:09:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:17 INFO - 'USER': 'cltbld', 08:09:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:17 INFO - 'XPC_FLAGS': '0x0', 08:09:17 INFO - 'XPC_SERVICE_NAME': '0', 08:09:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:17 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-PeI8Cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:17 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-64G8EN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:17 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-OnHxCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:17 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-xjrCNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:17 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-knf4fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:17 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-Cxg2KU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:18 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-9egJBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:18 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-hgy2Ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:18 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-QrXNY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:18 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-RtzGRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:18 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-JUcqJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:18 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-pR_jyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:18 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-9A_LS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:18 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-NgVLKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:18 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-VTdM3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:19 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-DDeQnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:19 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-dPDDZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:09:19 INFO - Running setup.py install for manifestparser 08:09:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:09:19 INFO - Running setup.py install for mozcrash 08:09:19 INFO - Running setup.py install for mozdebug 08:09:19 INFO - Running setup.py install for mozdevice 08:09:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:09:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:09:19 INFO - Running setup.py install for mozfile 08:09:19 INFO - Running setup.py install for mozhttpd 08:09:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:09:20 INFO - Running setup.py install for mozinfo 08:09:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:09:20 INFO - Running setup.py install for mozInstall 08:09:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:09:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:09:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:09:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:09:20 INFO - Running setup.py install for mozleak 08:09:20 INFO - Running setup.py install for mozlog 08:09:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:09:20 INFO - Running setup.py install for moznetwork 08:09:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:09:20 INFO - Running setup.py install for mozprocess 08:09:21 INFO - Running setup.py install for mozprofile 08:09:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:09:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:09:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:09:21 INFO - Running setup.py install for mozrunner 08:09:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:09:21 INFO - Running setup.py install for mozscreenshot 08:09:21 INFO - Running setup.py install for moztest 08:09:21 INFO - Running setup.py install for mozversion 08:09:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:09:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:09:21 INFO - Cleaning up... 08:09:21 INFO - Return code: 0 08:09:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:21 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')]} 08:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:21 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')]} 08:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:21 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 0x101fc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fcb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6dae00fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e67d30>, '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 0x101c8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e5eb20>, '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.rZvIbX0oOt/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.gIQ5wWsKDC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 08:09:21 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 08:09:21 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 08:09:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rZvIbX0oOt/Render', 08:09:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:21 INFO - 'HOME': '/Users/cltbld', 08:09:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:21 INFO - 'LOGNAME': 'cltbld', 08:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:21 INFO - 'MOZ_NO_REMOTE': '1', 08:09:21 INFO - 'NO_EM_RESTART': '1', 08:09:21 INFO - 'PAGER': '/bin/cat', 08:09:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:21 INFO - 'PWD': '/builds/slave/test', 08:09:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:21 INFO - 'SHELL': '/bin/bash', 08:09:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIQ5wWsKDC/Listeners', 08:09:21 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 08:09:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:21 INFO - 'USER': 'cltbld', 08:09:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:21 INFO - 'XPC_FLAGS': '0x0', 08:09:21 INFO - 'XPC_SERVICE_NAME': '0', 08:09:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:22 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-UIhlnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:22 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)) 08:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:22 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-e8Y_tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:22 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)) 08:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:22 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-LPdB8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:22 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)) 08:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:22 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-sOp9pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:22 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)) 08:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:22 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-vnpldr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:22 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)) 08:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:22 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-kfIEC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:22 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)) 08:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:22 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-nyEt6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:22 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)) 08:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:22 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-O0bEfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:22 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)) 08:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:22 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-n9yrbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:23 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)) 08:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:23 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-gnVNnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:23 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)) 08:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:23 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-WjRn7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:23 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)) 08:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:23 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-DHJe_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:23 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)) 08:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:23 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-mMaIP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:23 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)) 08:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:23 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-qWUKWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:23 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)) 08:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:23 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-5iIr24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:23 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)) 08:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:23 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-Bz9ckF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:23 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)) 08:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:23 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-66pv1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:23 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)) 08:09:23 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)) 08:09:23 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)) 08:09:23 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)) 08:09:23 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)) 08:09:23 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)) 08:09:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09:26 INFO - Downloading blessings-1.6.tar.gz 08:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:09:26 INFO - Installing collected packages: blessings 08:09:26 INFO - Running setup.py install for blessings 08:09:26 INFO - Successfully installed blessings 08:09:26 INFO - Cleaning up... 08:09:26 INFO - Return code: 0 08:09:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:09:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:26 INFO - Reading from file tmpfile_stdout 08:09:26 INFO - Current package versions: 08:09:26 INFO - blessings == 1.6 08:09:26 INFO - blobuploader == 1.2.4 08:09:26 INFO - docopt == 0.6.1 08:09:26 INFO - manifestparser == 1.1 08:09:26 INFO - mozInstall == 1.12 08:09:26 INFO - mozcrash == 0.16 08:09:26 INFO - mozdebug == 0.1 08:09:26 INFO - mozdevice == 0.48 08:09:26 INFO - mozfile == 1.2 08:09:26 INFO - mozhttpd == 0.7 08:09:26 INFO - mozinfo == 0.9 08:09:26 INFO - mozleak == 0.1 08:09:26 INFO - mozlog == 3.1 08:09:26 INFO - moznetwork == 0.27 08:09:26 INFO - mozprocess == 0.22 08:09:26 INFO - mozprofile == 0.28 08:09:26 INFO - mozrunner == 6.11 08:09:26 INFO - mozscreenshot == 0.1 08:09:26 INFO - mozsystemmonitor == 0.0 08:09:26 INFO - moztest == 0.7 08:09:26 INFO - mozversion == 1.4 08:09:26 INFO - psutil == 3.1.1 08:09:26 INFO - requests == 1.2.3 08:09:26 INFO - wsgiref == 0.1.2 08:09:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:26 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 0x101fc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fcb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6dae00fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e67d30>, '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 0x101c8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e5eb20>, '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.rZvIbX0oOt/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.gIQ5wWsKDC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 08:09:26 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 08:09:26 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 08:09:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rZvIbX0oOt/Render', 08:09:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:26 INFO - 'HOME': '/Users/cltbld', 08:09:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:26 INFO - 'LOGNAME': 'cltbld', 08:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:26 INFO - 'MOZ_NO_REMOTE': '1', 08:09:26 INFO - 'NO_EM_RESTART': '1', 08:09:26 INFO - 'PAGER': '/bin/cat', 08:09:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:26 INFO - 'PWD': '/builds/slave/test', 08:09:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:26 INFO - 'SHELL': '/bin/bash', 08:09:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIQ5wWsKDC/Listeners', 08:09:26 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 08:09:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:26 INFO - 'USER': 'cltbld', 08:09:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:26 INFO - 'XPC_FLAGS': '0x0', 08:09:26 INFO - 'XPC_SERVICE_NAME': '0', 08:09:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:27 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)) 08:09:27 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)) 08:09:27 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)) 08:09:27 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)) 08:09:27 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)) 08:09:27 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)) 08:09:27 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)) 08:09:27 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)) 08:09:27 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)) 08:09:27 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)) 08:09:27 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)) 08:09:27 INFO - Cleaning up... 08:09:27 INFO - Return code: 0 08:09:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:09: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')]} 08:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09: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')]} 08:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101fc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fcb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6dae00fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e67d30>, '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 0x101c8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e5eb20>, '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.rZvIbX0oOt/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.gIQ5wWsKDC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 08:09: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', 'jsonschema'] in /builds/slave/test/build 08:09: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 jsonschema 08:09:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rZvIbX0oOt/Render', 08:09:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:27 INFO - 'HOME': '/Users/cltbld', 08:09:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:27 INFO - 'LOGNAME': 'cltbld', 08:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:27 INFO - 'MOZ_NO_REMOTE': '1', 08:09:27 INFO - 'NO_EM_RESTART': '1', 08:09:27 INFO - 'PAGER': '/bin/cat', 08:09:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:27 INFO - 'PWD': '/builds/slave/test', 08:09:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:27 INFO - 'SHELL': '/bin/bash', 08:09:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIQ5wWsKDC/Listeners', 08:09:27 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 08:09:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:27 INFO - 'USER': 'cltbld', 08:09:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:27 INFO - 'XPC_FLAGS': '0x0', 08:09:27 INFO - 'XPC_SERVICE_NAME': '0', 08:09:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:27 INFO - Downloading/unpacking jsonschema 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:09:29 INFO - Downloading/unpacking functools32 (from jsonschema) 08:09:29 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 08:09:29 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 08:09:29 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 08:09:29 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 08:09:29 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 08:09:29 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 08:09:30 INFO - Downloading functools32-3.2.3-2.tar.gz 08:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:09:30 INFO - warning: no files found matching '*.txt' 08:09:30 INFO - no previously-included directories found matching 'build' 08:09:30 INFO - no previously-included directories found matching 'dist' 08:09:30 INFO - no previously-included directories found matching '.git*' 08:09:30 INFO - Installing collected packages: jsonschema, functools32 08:09:30 INFO - Running setup.py install for functools32 08:09:30 INFO - warning: no files found matching '*.txt' 08:09:30 INFO - no previously-included directories found matching 'build' 08:09:30 INFO - no previously-included directories found matching 'dist' 08:09:30 INFO - no previously-included directories found matching '.git*' 08:09:30 INFO - Successfully installed jsonschema functools32 08:09:30 INFO - Cleaning up... 08:09:30 INFO - Return code: 0 08:09:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:09: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')]} 08:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09: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')]} 08:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101fc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fcb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6dae00fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e67d30>, '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 0x101c8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e5eb20>, '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.rZvIbX0oOt/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.gIQ5wWsKDC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 08:09: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', 'flake8'] in /builds/slave/test/build 08:09: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 flake8 08:09:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rZvIbX0oOt/Render', 08:09:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:30 INFO - 'HOME': '/Users/cltbld', 08:09:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:30 INFO - 'LOGNAME': 'cltbld', 08:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:30 INFO - 'MOZ_NO_REMOTE': '1', 08:09:30 INFO - 'NO_EM_RESTART': '1', 08:09:30 INFO - 'PAGER': '/bin/cat', 08:09:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:30 INFO - 'PWD': '/builds/slave/test', 08:09:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:30 INFO - 'SHELL': '/bin/bash', 08:09:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIQ5wWsKDC/Listeners', 08:09:30 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 08:09:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:30 INFO - 'USER': 'cltbld', 08:09:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:30 INFO - 'XPC_FLAGS': '0x0', 08:09:30 INFO - 'XPC_SERVICE_NAME': '0', 08:09:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:30 INFO - Downloading/unpacking flake8 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:09:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:09:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:09:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:09:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:09:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:09:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:09:34 INFO - no previously-included directories found matching 'docs/_build' 08:09:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:09:34 INFO - Running setup.py install for pep8 08:09:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:09:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:09:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:09:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:09:34 INFO - no previously-included directories found matching 'docs/_build' 08:09:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:09:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:09:34 INFO - Cleaning up... 08:09:34 INFO - Return code: 0 08:09:34 INFO - Running post-action listener: _resource_record_post_action 08:09:34 INFO - Running post-action listener: _start_resource_monitoring 08:09:34 INFO - Starting resource monitoring. 08:09:34 INFO - ##### 08:09:34 INFO - ##### Running install step. 08:09:34 INFO - ##### 08:09:34 INFO - Running pre-action listener: _resource_record_pre_action 08:09:34 INFO - Running main action method: install 08:09:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:34 INFO - Reading from file tmpfile_stdout 08:09:34 INFO - Detecting whether we're running mozinstall >=1.0... 08:09:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:09:35 INFO - Reading from file tmpfile_stdout 08:09:35 INFO - Output received: 08:09:35 INFO - Usage: mozinstall [options] installer 08:09:35 INFO - Options: 08:09:35 INFO - -h, --help show this help message and exit 08:09:35 INFO - -d DEST, --destination=DEST 08:09:35 INFO - Directory to install application into. [default: 08:09:35 INFO - "/builds/slave/test"] 08:09:35 INFO - --app=APP Application being installed. [default: firefox] 08:09:35 INFO - mkdir: /builds/slave/test/build/application 08:09:35 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'] 08:09:35 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 08:10:08 INFO - Reading from file tmpfile_stdout 08:10:08 INFO - Output received: 08:10:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:10:08 INFO - Running post-action listener: _resource_record_post_action 08:10:08 INFO - ##### 08:10:08 INFO - ##### Running run-tests step. 08:10:08 INFO - ##### 08:10:08 INFO - Running pre-action listener: _resource_record_pre_action 08:10:08 INFO - Running main action method: run_tests 08:10:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:10:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:10:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:10:08 INFO - 2016-02-10 08:10:08.685 screenresolution[2564:29388] starting screenresolution argv=screenresolution get 08:10:08 INFO - 2016-02-10 08:10:08.687 screenresolution[2564:29388] Display 0: 1600x1200x32@60 08:10:08 INFO - 2016-02-10 08:10:08.693 screenresolution[2565:29390] starting screenresolution argv=screenresolution list 08:10:08 INFO - Available Modes on Display 0 08:10:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:10:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:10:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:10:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:10:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:10:08 INFO - Intel Iris: 08:10:08 INFO - Chipset Model: Intel Iris 08:10:08 INFO - Type: GPU 08:10:08 INFO - Bus: Built-In 08:10:08 INFO - VRAM (Dynamic, Max): 1536 MB 08:10:08 INFO - Vendor: Intel (0x8086) 08:10:08 INFO - Device ID: 0x0a2e 08:10:08 INFO - Revision ID: 0x0009 08:10:08 INFO - Displays: 08:10:08 INFO - Display: 08:10:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:10:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:10:08 INFO - Display Serial Number: 1600x1200 60 08:10:08 INFO - Main Display: Yes 08:10:08 INFO - Mirror: Off 08:10:08 INFO - Online: Yes 08:10:08 INFO - Rotation: Supported 08:10:08 INFO - Return code: 0 08:10:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:10:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:10:08 INFO - Python 2.7.3 08:10:08 INFO - Return code: 0 08:10:08 INFO - grabbing minidump binary from tooltool 08:10:08 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')]} 08:10:08 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 0x101e67d30>, '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 0x101c8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e5eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:10:08 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 08:10:08 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 08:10:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:10:09 INFO - Return code: 0 08:10:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:10:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:10:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:10:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:10:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:10:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:10:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:10:10 INFO - Return code: 0 08:10:10 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/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0117', '--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 08:10:10 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/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0117 --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 08:10:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rZvIbX0oOt/Render', 08:10:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:10 INFO - 'HOME': '/Users/cltbld', 08:10:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:10 INFO - 'LOGNAME': 'cltbld', 08:10:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:10:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:10 INFO - 'MOZ_NO_REMOTE': '1', 08:10:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:10:10 INFO - 'NO_EM_RESTART': '1', 08:10:10 INFO - 'PAGER': '/bin/cat', 08:10:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:10 INFO - 'PWD': '/builds/slave/test', 08:10:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:10:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:10 INFO - 'SHELL': '/bin/bash', 08:10:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIQ5wWsKDC/Listeners', 08:10:10 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 08:10:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:10 INFO - 'USER': 'cltbld', 08:10:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:10 INFO - 'XPC_FLAGS': '0x0', 08:10:10 INFO - 'XPC_SERVICE_NAME': '0', 08:10:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:10 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/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0117', '--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 08:10:10 INFO - mozversion application_buildid: 20160210063321 08:10:10 INFO - mozversion application_changeset: 6e66d7b4e9572fc86037401b618408d2a58b3c25 08:10:10 INFO - mozversion application_display_name: Nightly 08:10:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:10:10 INFO - mozversion application_name: Firefox 08:10:10 INFO - mozversion application_remotingname: firefox 08:10:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:10:10 INFO - mozversion application_vendor: Mozilla 08:10:10 INFO - mozversion application_version: 47.0a1 08:10:10 INFO - mozversion platform_buildid: 20160210063321 08:10:10 INFO - mozversion platform_changeset: 6e66d7b4e9572fc86037401b618408d2a58b3c25 08:10:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:10:10 INFO - mozversion platform_version: 47.0a1 08:10:10 INFO - using testdate: 1455120610 08:10:10 INFO - actual date: 1455120610 08:10:10 INFO - starting webserver on 'localhost:58632' 08:10:10 INFO - SUITE-START | Running 2 tests 08:10:10 INFO - TEST-START | dromaeo_css 08:10:10 INFO - operating with platform_type : mac_ 08:10:10 INFO - Initialising browser for dromaeo_css test... 08:10:10 INFO - TEST-INFO | started process 2583 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmp14m_Ou/profile http://localhost:58632/getInfo.html) 08:10:12 INFO - PROCESS | 2583 | __metrics Screen width/height:1600/1200 08:10:12 INFO - PROCESS | 2583 | colorDepth:24 08:10:12 INFO - PROCESS | 2583 | Browser inner width/height: 1024/689 08:10:12 INFO - PROCESS | 2583 | __metrics 08:10:12 INFO - PROCESS | 2583 | 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" 08:10:12 INFO - PROCESS | 2583 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:10:13 INFO - TEST-INFO | 2583: exit 0 08:10:13 INFO - Browser initialized. 08:10:13 INFO - Running cycle 1/1 for dromaeo_css test... 08:10:13 INFO - TEST-INFO | started process 2586 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmp14m_Ou/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:10:25 INFO - PROCESS | 2586 | RSS: Main: 247123968 08:10:25 INFO - PROCESS | 2586 | 08:11:15 INFO - PROCESS | 2586 | 1455120675988 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] 08:13:26 INFO - PROCESS | 2586 | Cycle 1(1): loaded http://localhost:58632/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58632/tests/dromaeo/cssquery-ext.html) 08:13:27 INFO - PROCESS | 2586 | RSS: Main: 392794112 08:13:27 INFO - PROCESS | 2586 | 08:16:30 INFO - PROCESS | 2586 | Cycle 1(1): loaded http://localhost:58632/tests/dromaeo/cssquery-ext.html (next: http://localhost:58632/tests/dromaeo/cssquery-jquery.html) 08:16:31 INFO - PROCESS | 2586 | RSS: Main: 379301888 08:16:31 INFO - PROCESS | 2586 | 08:19:33 INFO - PROCESS | 2586 | Cycle 1(1): loaded http://localhost:58632/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58632/tests/dromaeo/cssquery-mootools.html) 08:19:33 INFO - PROCESS | 2586 | RSS: Main: 378433536 08:19:33 INFO - PROCESS | 2586 | 08:22:35 INFO - PROCESS | 2586 | Cycle 1(1): loaded http://localhost:58632/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58632/tests/dromaeo/cssquery-prototype.html) 08:22:36 INFO - PROCESS | 2586 | RSS: Main: 341008384 08:22:36 INFO - PROCESS | 2586 | 08:25:39 INFO - PROCESS | 2586 | Cycle 1(1): loaded http://localhost:58632/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58632/tests/dromaeo/cssquery-yui.html) 08:25:40 INFO - PROCESS | 2586 | RSS: Main: 343633920 08:25:40 INFO - PROCESS | 2586 | 08:28:43 INFO - PROCESS | 2586 | Cycle 1(1): loaded http://localhost:58632/tests/dromaeo/cssquery-yui.html (next: http://localhost:58632/tests/dromaeo/cssquery-dojo.html) 08:28:43 INFO - PROCESS | 2586 | RSS: Main: 381173760 08:28:43 INFO - PROCESS | 2586 | 08:28:43 INFO - PROCESS | 2586 | __start_tp_report 08:28:43 INFO - PROCESS | 2586 | _x_x_mozilla_page_load 08:28:43 INFO - PROCESS | 2586 | _x_x_mozilla_page_load_details 08:28:43 INFO - PROCESS | 2586 | |i|pagename|runs| 08:28:43 INFO - PROCESS | 2586 | |0;dojo.html;3013.969860301397;3423.469362248852;3429.262708517669;3439.4496880499123;3483.4426491761324;5534.4742249486235;5608.6073974821775;5632.211490391349;5651.5761317901115;5674.063779476387;5639.7180140993;5649.293838270216;5725.2843394575675;5783.768649254025;5792.768289268424;5049.84850454487;5079.085764562377;5100.693958362492;5117.462666420028;5213.58291336694;5192.065428222918;5215.817446389377;5234.476552344754;5249.658772179815;5283.445238249986;5065.873353166182;5083.593312534988;5148.459411761786;5161.509656582619;5180.45605211453;5120.359955005624;5153.072446959546;5159.58723302135;5170.146925757245;5181.844544663666;5070.822521211777;5095.643304968654;5115.948840511584;5120.692758434506;5153.948460515385;5478.58910581704;5573.247611572427;5604.887902241973;5614.438556144394;5643.746031428595;6091.72073864489;6197.318294987548;6201.379862013808;6209.6895155242055;6216.471599914013;6171.814845554641;6202.627842329474;6213.409726076015;6222.12890195373;6222.284437289724;5640.971795141039;5711.544036064491;5725.198472213893;5726.627769194989;5735.254416925773;6247.437730604177;6247.812565623039;6263.029230469285;6269.874602508015;6273.278572964076;5986.551008674367;5999.790007349722;6044.486218671462;6061.787837425669;6066.272047354346;6057.303410107806;6117.796956032686;6127.556056270569;6201.224846894138;6242.438180563771;5806.68063256525;6136.417040381157;6145.754169833246;6151.384861513813;6169.907451388232;6170.950938340493;6176.413240742122;6187.84530386744;6209.006558950547;6220.782272620437;4774.4509381421585;4823.348847905558;4834.274858771142;4835.323054772335;4849.563539281482;4338.76136812472;4343.478782546114;4397.406350142754;4423.447069116361;4459.687821852439;5584.457690101488;5597.6641401516035;5622.493975542221;5635.21107045014;5639.069553523623;6239.407256310643;6252.531060170505;6266.811995640138;6274.529410294246;6281.434670879643;5439.809606663748;5574.247476590689;5593.105103183471;5629.662220266797;5659.660420374791;5316.46835316473;5325.227841962894;5330.946690533123;5331.200319952039;5333.120035194227;6169.598976066542;6257.374262573706;6275.466585340298;6282.905756413657;6284.811455656338;6116.031445915052;6118.785842495491;6144.53915956314;6209.5032397409;6223.688815559294;6165.84585385351;6245.250569931637;6282.1519094921605;6295.276043255084;6300.464460520907;6123.510119190543;6124.173236613;6124.785632502841;6138;6139.4781443577795;6219.160413344322;6241.531885108544;6241.906371404341;6251.093591429309;6259.34276900937;5134.435212126588;5907.084401917709;5981.910271346021;5990.880182396415;6044.667543285162;5950.3454619992635;5968.343482217039;5971.373005834324;5974.283086029531;5999.790007349722;5723.8569035774435;5773.653580785166;5793.304803423616;5801.912971305518;5803.7968671096305;5792.899349123653;5937.109433584997;5952.404759524186;5959.910601340896;5960.821175364746;5049.293098966221;5774.48029677331;5908.615939963888;5912.408759124053;5912.46787789101 08:28:43 INFO - PROCESS | 2586 | |1;ext.html;485.06866815713823;492.89649173673524;575.3814649252053;579.2527639345245;617.05282391529;28835.134945951628;36960.630393696054;37528.43707344392;37665.62334376655;37759.62240377599;39737;39886.20227595446;39902.40146397799;40000.79997600069;40040.79979600098;9426.858597121032;9647.758806029835;9650.806983860319;9656.565454554562;9670.032996700344;9503.334766566342;9612.231021518297;9647.228221742278;9651.5174241288;9734.65928692496;9703.369280996749;9784.755381115494;9790.951045244763;9791.363561368524;9831.410115393064;8290.668373265062;9680.225581953462;9727.610895564168;9735.90264097357;9773.21814254858;9507.809843803085;9629.085236902552;9644.276679249015;9645.08371704687;9660.90339096607;38376.808115959524;38791.22417551661;38799.61200387988;38880.805595972124;39270.803645981876;3162.667919868427;3348.8808765218673;3361.478970759536;3531.2407832315916;3746.662800347982;26208.8689556551;27021;28182.577261341095;28185.013524526545;28295.292617684518;2716.4838680650614;2730.4675588260297;2822.943541129166;2857.1857020748985;2869.4834929712642;384483;472838;473543;474312;477948.9999999965;52135.739321303154;63329.68335158295;63501.09496715106;63501.68249158817;63506;67189;67212.32787672158;67417.98873016909;67498.32501675018;67563.98654020193;15742.212889355487;15821.288042038135;15834.366625334858;15951.601209969844;16064.919675401781;12278.631641050782;12362.75274494505;12367.752644947052;12385.504579816887;12386.690332741753;19380.321688740827;20147.19411223564;20159.891205983517;20185.192592296436;20237.98810059491;7345.77962661121;8588.65645374178;8881.911180888108;8888.644454221889;8896.377253592187;936.2089034765748;937.7139972308512;942.9434233945985;1019.9541020654088;1165.953361865516;28388.081895799205;29315;29361.412771744872;29579.704202958124;30397;1007.4660429972126;1042.551702767802;1086.5653738504504;1108.972275693098;1168.1705988748083;12703.42834572428;15053.623659408602;15752;15813.68372632541;15855.52433426999;641207;645115;646380;646615.7669211624;648978;54124;54606.90786184254;54660.453395466335;54796.17805732917;54937.175942360096;1232.6733415644862;1410.739013282546;1456.4319915233068;1456.5557504960877;1457.5190187237974;29470.557941630464;30588.235294117825;31108;31255.218619534695;31911;51828.222576662134;52498.73750631222;52525.47474525359;52531.73734131305;52538.21192682036;471381;476922;478922;479100;480066;41190.58809411868;41780.58219417767;42155.789221053696;42326.36510452284;42376;43774.562254378325;43929;44434;44834;45198;28551.14346569523;31370;32079;34803.477947830295;35190.472142917366;33476.33047339088;33677.49483757795;33715.494267586495;34112.82943585266;34166.487502686985;33556.98662576649;34148.487772683926;34216.82891585526;34529.654703452645;34544;23663.17178898799;30546.389072218877;32857.028738042725;33216.50175247325;33396.833015835735;24511.50976980486;24719.752802471747;24847.50304993854;24878.626820597343;25042.37394065163 08:28:43 INFO - PROCESS | 2586 | |2;jquery.html;311.5995945210405;361.13868423809214;364.2405584356616;366.490578096446;370.298284750398;18501.074946252684;18682.06589670518;19385.418437446882;20000.0999955002;20037.298694545694;13925.442982280696;15413.3834646614;18935;19928.601427971433;19936;5830.7084645767645;6237.563370564062;6381.1066450696935;6442.16251887254;6449.322821103787;4492.3710680504755;6333.271673757507;6467;6471.579347342431;6472.676366181696;4673.135469938073;4685.180093483644;4685.60172385346;4686.27362758773;6951.930480695204;7011.158660960667;7131.3938315243;7219.602921839297;7231.783046508614;7265.1645060818155;6793.354631310018;6871.209810871714;6873.828154296132;6877.449804015667;6893.517453778238;25206.747932520622;25262;25301.49397012068;26145;26196.476070478482;2272.6931864198286;2294.9426264343356;2315.30540837748;2328.172270883982;2460.6801115855005;14805;14928.566429721224;15216.163111028889;15335.079895206323;15821.525354239277;1835.85313174947;1853.2216469083016;1856.7400563921062;1893.0061717598232;1895.2134864031411;105513.47243263734;109643;109907;110064;111103;18072.457826265232;18355.56420505296;18482.81517184838;18500.629987400178;18542.25830966746;21811.781882180974;26311.73688263131;26316.473670526484;26860.865695671397;26911.596326055125;9218.492982886006;9770.804583908282;10130;10182.338148020355;10186.949065254626;8632.482051076955;8637.611307491177;8672.783180420414;8702.738917832476;8735.908011498563;8326.625301861432;8356.874646880302;8462.661493540189;8476.194761497647;8486.40595158333;2773.62556054934;3332.8166950817454;3339.3655205510877;3371.6291207967106;3378.493226016117;827.1149869639548;849.180540778152;883.1477624092653;945.9905400946041;1049.6011515624014;14579.781303280459;16344.598282963578;19720.506987325145;20250.291239806535;20296.898515507623;938.7887725261761;969.0842154164247;975.2198241406846;976.1848856205006;1034.9793004140026;10291.794164116676;10511.737206569896;10528.947355263328;10543.472826358651;10556.944305569381;583533;698158;714219;721815;731758;118741.49371594399;120566.39716801535;122155;123528;127541.36229318794;1146.6388087752332;1160.6924165096257;1181.2203945395997;1183.4496958913974;1186.4127257007835;17330.82669173292;17473.912630437277;17570.945743255445;17635.911820440815;17890.10549472547;40847;47880.521194789;48052.7597362025;49110.754446228966;51532.74233628808;67608;69001;69707.25731856744;70218;70672.29327706863;7493.550386976799;7758.612069396395;7832.942552755305;7842.843143136991;7845.725399610987;9387.85918211241;11800;11897.702557436134;11915.642530724092;12332.07509436778;9493.288003399635;9605.519724013631;10036.096751292418;10429.530671119666;10620.628278010232;10049.547770350498;10481.318714283547;10517.631882884063;10571.36571805694;10605.363678179334;4540.72755634663;7613.7437322843325;10376.481175941324;10524.947375263075;10691.732706682084;6307.684615769102;7611;7781.688732450639;7792.688292468464;7853.09689385728;9956.153726933291;10004.699859004242;10774.892251077388;10820.945895270474;10990.505427255634 08:28:43 INFO - PROCESS | 2586 | |3;mootools.html;1378.744932187546;1501.2343704710597;1519.3087145348868;1743.7122874725671;1923;7981.76054718358;8611.44025638334;8879.733607991755;8881.555922203881;8883.955580222106;8413.284870785976;8676.566171691406;8680.392372533925;8689.695860644879;8695.217430431276;2156.6657168138886;2221.7889300516426;2482.205694177859;2505.285993491855;2508.6237064440297;2477.492114116602;2532.8353657012326;2534.214393538009;2535.871537165962;2537.3656585853537;2422.4549476367765;2497.5504409206337;2503.3616427810975;2504.098524531167;2505.4112283613335;2454.3864033991504;2477.578811602032;2510.1967370441466;2511.7739403453593;2515.320863366899;2464.938376540583;2491.377155711072;2493.551160791057;2517.0686845867144;2522.041624182799;8920.598573064228;8956.417832840845;8992.77518062047;8994.730158095268;9007.909920900838;5403.7027963462;5549.38956714761;5561;5561.4716601922755;5567.749451274703;3653.671169594723;3684.336819372512;3760.5863355031197;3771.528558930134;3781.6785573226307;1050.3172937590627;1061.5435362793996;1062.516554967488;1091.939943303118;1100.5542755184163;12239.69400764988;12265;12266;12272.852250856064;12274.815877761841;4942.1104201244125;4958.628102892298;4985.700857948535;5054.873628159326;5066.873328166826;10363.792724145474;10368.792624147625;10372.585096596202;10377.429241391796;10400.47997600117;5584.497395234367;5586.385497595261;5588;5588.050031494656;5598.552115830724;4928.457869634337;5047.293378926953;5063.11395505785;5065.822696205615;5070.087384270793;3696.9075773105887;3769.9246015080093;3909.706771992112;3976.304146774303;3992.281389349887;997.8823717436518;1093.3767752381225;1260.174585646403;1311.3312210772574;1329.322045756671;1284.9229046257256;1291.8514370847286;1302.4724986380531;1316.394458549059;1345.7039451320693;8105.918940810634;8204.425690201748;8222.218889205516;8269.669213231524;8299.460535065202;1167.445463404876;1173.3253379306932;1176.5940750441255;1177.2112684501406;1193.2303664136584;6267.4045965633195;6360.936390636127;6369.904451433232;6374.808755737336;6376.936230637727;10366.326188797855;10537.9473102634;10588.841167382496;10727.892721072845;10743.677689669323;8794.296456283482;10248.282620216512;10569.841452378221;10574.154067674568;10640.308379955279;8302;8430.789230269293;8433.241008309282;8434.74695759116;8441.113683063313;8081.353491720531;8089.595520223847;8186.304164146114;8195.508269503849;8372.623231954454;9622.9037709622;9914.107730304308;9946.45294508809;9960.053794889764;10066.54700538463;10021.599136034478;10204.438755868201;10472;10477.790444190921;10506.15950723925;7546.584937828472;7602.239776022354;7605.6577454013595;7644.655990480553;7697.384209263134;7586.848263034819;7783.805404864697;8190.099089100075;8335.291500222549;8370.204830541088;7138.786406310835;7361.2638736125955;7764.029496312961;7881.369490440637;8034.959825200836;7729.884051739116;7735.342495887688;7773.533587984739;7819.530828150329;7844.4901081429525;7871.212878712312;7928.246816552418;7930.643121059451;7937.126916039116;7938.682452701827;7066.293370663098;7099.148102227766;7133;7154.713811447484;7164.283571642794;7202.96398518004;7259.455540834564;7261.201267860425;7276.163241227327;7276.781696549112 08:28:43 INFO - PROCESS | 2586 | |4;prototype.html;310.20896713380904;323.1726779444622;328.6089553431418;332.7537622159602;336.7020187134387;6612.140421745178;6624.403803657669;6635.137432133822;6649.800505984822;6671.199456065273;6541.901871471931;6580.177477815273;6584.539082264243;6597;6637;4882.780274887638;4902.65681402302;4906.975465122669;4913.680610760289;4923.015396920612;4643.396358473394;4804.279358096279;4810.158222311082;4810.182269014258;4812.446568644616;4730.62155027597;4746.715197088169;4753.524647535253;4762.166620841356;4771.308160316752;3875.9147438717205;4585.656075794295;4728.054389122155;4742.359781429497;4751.311059896313;4008.4388185654034;4017.216642754664;4017.578154293786;4025.0943537704075;4027.3153563894207;6062.727177276989;6281.842953926142;6321.336259692712;6369.9171140906155;6373.521985851034;5612.186232996192;5630.887382252373;5636.464535869086;5643.125315576051;5650.208970744099;6655.500837437212;6762.560433571802;7059.964700176518;7060.717571297142;7071.823204419879;4518.615917647004;4556.635469162459;4558.293464513005;4579.63362930968;4586.128635559233;6037.78867739627;7319.890201646979;7366.5948372839475;7395.2235015323695;7416.740414085535;4594.241950078266;4609.400777898919;4627.051454451829;4629.120467111238;4630.791614377361;4674.415698037746;4687.859364219079;4691.038337140878;4701.224297990793;4702.858914232578;5308.150695888639;5380.650257733235;5395.541378982831;5397.595180361489;5403.891922161613;6007.098935159761;6839.555428897106;6844.726210951606;6937.271586483447;7005.824854378681;1594.2666373468103;1614.7254966655696;1615.5234205909285;1616.692828362631;1617.44198251603;908.3459908865606;986.1716158426813;1031.742064483879;1053.489057806963;1057.259918057363;6509;6547.476201903836;6600.405963463311;6600.900986485207;6605.405513503808;7309.232530584319;7311.634418279064;7316.670749816271;7342.4493163012985;7349.889751653729;6417.614943103429;6572.901406478906;6578.177727784027;6598.637074960827;6608.207015158212;3247.707706306444;3772.6607054495807;3871.457995880579;3872.4191371294532;3874.244522318177;7557.773266802004;7574.166841647414;7576.962115189499;7581.052368453943;7586.696532138763;6396.136521569621;7157.284271572905;7221.566705997657;7390.371818395389;7538.3592394645975;7557.093148822177;7594.886076708854;7606.885896711443;7612.885806712904;7621.923780762232;7249.238829922993;7261.745838895613;7263.745768898063;7280.381167600814;7291.854162916606;7002.323780015533;7132.646226745058;7312.597807120659;7333.266673332624;7334.486585938933;7701.768946931601;7710.421718371257;7729.690812367442;7736.381089512938;7738.303552680286;4666.486686464554;4699.553542413465;4709;4713.764311784328;4718.245080787057;7078.362947334765;7173.246809084971;7270.382017528569;7387.7783666490095;7413.666385012795;6962.268961758942;7056.15326160864;7122.358987691133;7142.892856607259;7168.426525877813;7130.7147714092935;7158.141023077056;7172.282771722995;7178.856422871618;7184.9640751798;5981;6743.35938085881;6929.3070692930305;6947.5831450113155;6954.478414119062;7098.574085554883;7104.964475177591;7113.110861142357;7113.893291600527;7125.251848556034;6815.591064535945;6925.826854328682;6962.721491140298;6966.1988871280455;6973.093497845248 08:28:43 INFO - PROCESS | 2586 | |5;yui.html;657.3262406033815;667.71955778573;669.9966500167499;745.9030326057612;762.8512440074185;14426.855731442696;14627.707445851076;14645.267736613167;14652.120872747615;14679.559613211593;15094.018888772249;15447.845521544781;15476.226188690549;15476.226188690549;15497.302621382036;694.2467422846217;700.6181631011111;829.7593697827638;859.896812382515;865.5412631305418;851.059579165023;861.1689719420789;863.7236084452977;866.0084203586889;866.0343716755835;912.0605776050678;913.3880300198882;913.6025828764475;914.1863741270275;914.8444764390036;729.5804912175494;738.3318097122113;899.9145081217274;904.3082042237694;913.5295322908707;663.1677245057422;665.218368417108;665.8634979829123;669.0132055218562;674.2078058281548;14883.776743348859;14944.178070206135;14971.625709357244;14980;15009.324580393908;12395.75208495825;12654.55709050188;12778.297193654345;12789.168704034208;12895.484180632764;10134.13859821916;10150.340227885164;10176.745581360452;10337.0696637303;10964.890351096547;3441.82790860456;3508.333416650828;3580.6240344763687;3620.2216523447587;3635.182084031072;72953;74320;74800.5039899199;83438;85275.57362213211;9669.081437263449;9688.806223875483;9736.95131524338;9894.158996485236;9942.850857237147;21246.25638102659;21277.574448510943;21297;21319.65483796781;21366.572668546854;7709.151993280735;7769.223077692299;7802;7836.608169591497;7911.84176316482;4160.895977600524;4164.5210800758305;4172.937405938914;4235.131797981407;4244.830206791756;3512.7014203792965;3563.3585954527916;3565.0552603560077;3566.0193446802336;3567.5897271813556;647.5531883000715;656.0127008851648;657.8421178917025;664.0371461381017;665.1585744033802;553.5212041584001;599.5293694449836;625.9499240060875;627.3569591169088;631.5579094633774;8618.482891026559;8652.740417787476;8761.211490965843;8815.206631403076;9037.367384283038;423.686472010716;506.71370675568187;517.1725239616584;581.8138195777395;615.2524682510771;3130.7808453408043;3982.522097348337;4275.166342563232;4349.478062632441;4378.846740364135;71162.64418677874;87111.77329360259;87610.80972975599;88754;88900.5554972221;69322.3067769326;69718;69771.65114174498;70054.9491757624;71980;70194.64902675556;70475.29524704687;71381;71477.6426117866;71664.56670866658;8895.777605559913;8986.86519702192;8989.775255618662;9079.24494390985;9104.863427048733;48664.2700359502;49290.76773080702;49635.751821240665;50854.7286317845;51150.20974265883;66529.66735166294;67434;67865.66067169633;68432.6578367105;69640.95538566825;11045.944770276097;11105.500252488819;11187.888121118685;11200.831987520356;11568.762543809831;11995.520179193083;12110.091743119478;12133.39333033327;12171.817422738843;12899;11475.942620286845;11730.824037639613;11824.704382390164;11843.170978031456;12151.210171338835;11439.08487321029;11697.415129243675;11900.880991189977;11903.464344104363;11969.760604787682;6960.408365288805;10981.286216395909;11361.431928403712;11398.658040258806;12233;9637.036296370306;9757.219422446045;9801.656942006995;9829.705108846745;9845.704628861145;9705.272104592324;9713.320067595201;9736.805263894541;9738.415695058318;9747.512624368896 08:28:43 INFO - PROCESS | 2586 | __end_tp_report 08:28:43 INFO - PROCESS | 2586 | __start_cc_report 08:28:43 INFO - PROCESS | 2586 | _x_x_mozilla_cycle_collect,1330 08:28:43 INFO - PROCESS | 2586 | __end_cc_report 08:28:43 INFO - PROCESS | 2586 | __startTimestamp1455121723542__endTimestamp 08:28:43 INFO - PROCESS | 2586 | 08:28:43 INFO - PROCESS | 2586 | ------- Summary: start ------- 08:28:43 INFO - PROCESS | 2586 | Number of tests: 6 08:28:43 INFO - PROCESS | 2586 | 08:28:43 INFO - PROCESS | 2586 | [#0] dojo.html Cycles:165 Average:5669.13 Median:5801.91 stddev:635.43 (11.0%) stddev-sans-first:602.28 08:28:43 INFO - PROCESS | 2586 | Values: 3014.0 3423.5 3429.3 3439.4 3483.4 5534.5 5608.6 5632.2 5651.6 5674.1 5639.7 5649.3 5725.3 5783.8 5792.8 5049.8 5079.1 5100.7 5117.5 5213.6 5192.1 5215.8 5234.5 5249.7 5283.4 5065.9 5083.6 5148.5 5161.5 5180.5 5120.4 5153.1 5159.6 5170.1 5181.8 5070.8 5095.6 5115.9 5120.7 5153.9 5478.6 5573.2 5604.9 5614.4 5643.7 6091.7 6197.3 6201.4 6209.7 6216.5 6171.8 6202.6 6213.4 6222.1 6222.3 5641.0 5711.5 5725.2 5726.6 5735.3 6247.4 6247.8 6263.0 6269.9 6273.3 5986.6 5999.8 6044.5 6061.8 6066.3 6057.3 6117.8 6127.6 6201.2 6242.4 5806.7 6136.4 6145.8 6151.4 6169.9 6171.0 6176.4 6187.8 6209.0 6220.8 4774.5 4823.3 4834.3 4835.3 4849.6 4338.8 4343.5 4397.4 4423.4 4459.7 5584.5 5597.7 5622.5 5635.2 5639.1 6239.4 6252.5 6266.8 6274.5 6281.4 5439.8 5574.2 5593.1 5629.7 5659.7 5316.5 5325.2 5330.9 5331.2 5333.1 6169.6 6257.4 6275.5 6282.9 6284.8 6116.0 6118.8 6144.5 6209.5 6223.7 6165.8 6245.3 6282.2 6295.3 6300.5 6123.5 6124.2 6124.8 6138.0 6139.5 6219.2 6241.5 6241.9 6251.1 6259.3 5134.4 5907.1 5981.9 5990.9 6044.7 5950.3 5968.3 5971.4 5974.3 5999.8 5723.9 5773.7 5793.3 5801.9 5803.8 5792.9 5937.1 5952.4 5959.9 5960.8 5049.3 5774.5 5908.6 5912.4 5912.5 08:28:43 INFO - PROCESS | 2586 | 08:28:43 INFO - PROCESS | 2586 | [#1] ext.html Cycles:180 Average:66389.14 Median:38840.21 stddev:142513.59 (366.9%) stddev-sans-first:142827.47 08:28:43 INFO - PROCESS | 2586 | Values: 485.1 492.9 575.4 579.3 617.1 28835.1 36960.6 37528.4 37665.6 37759.6 39737.0 39886.2 39902.4 40000.8 40040.8 9426.9 9647.8 9650.8 9656.6 9670.0 9503.3 9612.2 9647.2 9651.5 9734.7 9703.4 9784.8 9791.0 9791.4 9831.4 8290.7 9680.2 9727.6 9735.9 9773.2 9507.8 9629.1 9644.3 9645.1 9660.9 38376.8 38791.2 38799.6 38880.8 39270.8 3162.7 3348.9 3361.5 3531.2 3746.7 26208.9 27021.0 28182.6 28185.0 28295.3 2716.5 2730.5 2822.9 2857.2 2869.5 384483.0 472838.0 473543.0 474312.0 477949.0 52135.7 63329.7 63501.1 63501.7 63506.0 67189.0 67212.3 67418.0 67498.3 67564.0 15742.2 15821.3 15834.4 15951.6 16064.9 12278.6 12362.8 12367.8 12385.5 12386.7 19380.3 20147.2 20159.9 20185.2 20238.0 7345.8 8588.7 8881.9 8888.6 8896.4 936.2 937.7 942.9 1020.0 1166.0 28388.1 29315.0 29361.4 29579.7 30397.0 1007.5 1042.6 1086.6 1109.0 1168.2 12703.4 15053.6 15752.0 15813.7 15855.5 641207.0 645115.0 646380.0 646615.8 648978.0 54124.0 54606.9 54660.5 54796.2 54937.2 1232.7 1410.7 1456.4 1456.6 1457.5 29470.6 30588.2 31108.0 31255.2 31911.0 51828.2 52498.7 52525.5 52531.7 52538.2 471381.0 476922.0 478922.0 479100.0 480066.0 41190.6 41780.6 42155.8 42326.4 42376.0 43774.6 43929.0 44434.0 44834.0 45198.0 28551.1 31370.0 32079.0 34803.5 35190.5 33476.3 33677.5 33715.5 34112.8 34166.5 33557.0 34148.5 34216.8 34529.7 34544.0 23663.2 30546.4 32857.0 33216.5 33396.8 24511.5 24719.8 24847.5 24878.6 25042.4 08:28:43 INFO - PROCESS | 2586 | 08:28:43 INFO - PROCESS | 2586 | [#2] jquery.html Cycles:180 Average:37291.00 Median:26314.11 stddev:114255.78 (434.2%) stddev-sans-first:114542.56 08:28:43 INFO - PROCESS | 2586 | Values: 311.6 361.1 364.2 366.5 370.3 18501.1 18682.1 19385.4 20000.1 20037.3 13925.4 15413.4 18935.0 19928.6 19936.0 5830.7 6237.6 6381.1 6442.2 6449.3 4492.4 6333.3 6467.0 6471.6 6472.7 4673.1 4685.2 4685.6 4686.3 6951.9 7011.2 7131.4 7219.6 7231.8 7265.2 6793.4 6871.2 6873.8 6877.4 6893.5 25206.7 25262.0 25301.5 26145.0 26196.5 2272.7 2294.9 2315.3 2328.2 2460.7 14805.0 14928.6 15216.2 15335.1 15821.5 1835.9 1853.2 1856.7 1893.0 1895.2 105513.5 109643.0 109907.0 110064.0 111103.0 18072.5 18355.6 18482.8 18500.6 18542.3 21811.8 26311.7 26316.5 26860.9 26911.6 9218.5 9770.8 10130.0 10182.3 10186.9 8632.5 8637.6 8672.8 8702.7 8735.9 8326.6 8356.9 8462.7 8476.2 8486.4 2773.6 3332.8 3339.4 3371.6 3378.5 827.1 849.2 883.1 946.0 1049.6 14579.8 16344.6 19720.5 20250.3 20296.9 938.8 969.1 975.2 976.2 1035.0 10291.8 10511.7 10528.9 10543.5 10556.9 583533.0 698158.0 714219.0 721815.0 731758.0 118741.5 120566.4 122155.0 123528.0 127541.4 1146.6 1160.7 1181.2 1183.4 1186.4 17330.8 17473.9 17570.9 17635.9 17890.1 40847.0 47880.5 48052.8 49110.8 51532.7 67608.0 69001.0 69707.3 70218.0 70672.3 7493.6 7758.6 7832.9 7842.8 7845.7 9387.9 11800.0 11897.7 11915.6 12332.1 9493.3 9605.5 10036.1 10429.5 10620.6 10049.5 10481.3 10517.6 10571.4 10605.4 4540.7 7613.7 10376.5 10524.9 10691.7 6307.7 7611.0 7781.7 7792.7 7853.1 9956.2 10004.7 10774.9 10820.9 10990.5 08:28:43 INFO - PROCESS | 2586 | 08:28:43 INFO - PROCESS | 2586 | [#3] mootools.html Cycles:180 Average:6165.12 Median:5064.47 stddev:3234.46 (63.9%) stddev-sans-first:3223.52 08:28:43 INFO - PROCESS | 2586 | Values: 1378.7 1501.2 1519.3 1743.7 1923.0 7981.8 8611.4 8879.7 8881.6 8884.0 8413.3 8676.6 8680.4 8689.7 8695.2 2156.7 2221.8 2482.2 2505.3 2508.6 2477.5 2532.8 2534.2 2535.9 2537.4 2422.5 2497.6 2503.4 2504.1 2505.4 2454.4 2477.6 2510.2 2511.8 2515.3 2464.9 2491.4 2493.6 2517.1 2522.0 8920.6 8956.4 8992.8 8994.7 9007.9 5403.7 5549.4 5561.0 5561.5 5567.7 3653.7 3684.3 3760.6 3771.5 3781.7 1050.3 1061.5 1062.5 1091.9 1100.6 12239.7 12265.0 12266.0 12272.9 12274.8 4942.1 4958.6 4985.7 5054.9 5066.9 10363.8 10368.8 10372.6 10377.4 10400.5 5584.5 5586.4 5588.0 5588.1 5598.6 4928.5 5047.3 5063.1 5065.8 5070.1 3696.9 3769.9 3909.7 3976.3 3992.3 997.9 1093.4 1260.2 1311.3 1329.3 1284.9 1291.9 1302.5 1316.4 1345.7 8105.9 8204.4 8222.2 8269.7 8299.5 1167.4 1173.3 1176.6 1177.2 1193.2 6267.4 6360.9 6369.9 6374.8 6376.9 10366.3 10537.9 10588.8 10727.9 10743.7 8794.3 10248.3 10569.8 10574.2 10640.3 8302.0 8430.8 8433.2 8434.7 8441.1 8081.4 8089.6 8186.3 8195.5 8372.6 9622.9 9914.1 9946.5 9960.1 10066.5 10021.6 10204.4 10472.0 10477.8 10506.2 7546.6 7602.2 7605.7 7644.7 7697.4 7586.8 7783.8 8190.1 8335.3 8370.2 7138.8 7361.3 7764.0 7881.4 8035.0 7729.9 7735.3 7773.5 7819.5 7844.5 7871.2 7928.2 7930.6 7937.1 7938.7 7066.3 7099.1 7133.0 7154.7 7164.3 7203.0 7259.5 7261.2 7276.2 7276.8 08:28:43 INFO - PROCESS | 2586 | 08:28:43 INFO - PROCESS | 2586 | [#4] prototype.html Cycles:180 Average:5743.51 Median:6597.82 stddev:1856.44 (28.1%) stddev-sans-first:1816.31 08:28:43 INFO - PROCESS | 2586 | Values: 310.2 323.2 328.6 332.8 336.7 6612.1 6624.4 6635.1 6649.8 6671.2 6541.9 6580.2 6584.5 6597.0 6637.0 4882.8 4902.7 4907.0 4913.7 4923.0 4643.4 4804.3 4810.2 4810.2 4812.4 4730.6 4746.7 4753.5 4762.2 4771.3 3875.9 4585.7 4728.1 4742.4 4751.3 4008.4 4017.2 4017.6 4025.1 4027.3 6062.7 6281.8 6321.3 6369.9 6373.5 5612.2 5630.9 5636.5 5643.1 5650.2 6655.5 6762.6 7060.0 7060.7 7071.8 4518.6 4556.6 4558.3 4579.6 4586.1 6037.8 7319.9 7366.6 7395.2 7416.7 4594.2 4609.4 4627.1 4629.1 4630.8 4674.4 4687.9 4691.0 4701.2 4702.9 5308.2 5380.7 5395.5 5397.6 5403.9 6007.1 6839.6 6844.7 6937.3 7005.8 1594.3 1614.7 1615.5 1616.7 1617.4 908.3 986.2 1031.7 1053.5 1057.3 6509.0 6547.5 6600.4 6600.9 6605.4 7309.2 7311.6 7316.7 7342.4 7349.9 6417.6 6572.9 6578.2 6598.6 6608.2 3247.7 3772.7 3871.5 3872.4 3874.2 7557.8 7574.2 7577.0 7581.1 7586.7 6396.1 7157.3 7221.6 7390.4 7538.4 7557.1 7594.9 7606.9 7612.9 7621.9 7249.2 7261.7 7263.7 7280.4 7291.9 7002.3 7132.6 7312.6 7333.3 7334.5 7701.8 7710.4 7729.7 7736.4 7738.3 4666.5 4699.6 4709.0 4713.8 4718.2 7078.4 7173.2 7270.4 7387.8 7413.7 6962.3 7056.2 7122.4 7142.9 7168.4 7130.7 7158.1 7172.3 7178.9 7185.0 5981.0 6743.4 6929.3 6947.6 6954.5 7098.6 7105.0 7113.1 7113.9 7125.3 6815.6 6925.8 6962.7 6966.2 6973.1 08:28:43 INFO - PROCESS | 2586 | 08:28:43 INFO - PROCESS | 2586 | [#5] yui.html Cycles:180 Average:17936.93 Median:656.67 stddev:24504.72 (3731.7%) stddev-sans-first:24539.11 08:28:43 INFO - PROCESS | 2586 | Values: 657.3 667.7 670.0 745.9 762.9 14426.9 14627.7 14645.3 14652.1 14679.6 15094.0 15447.8 15476.2 15476.2 15497.3 694.2 700.6 829.8 859.9 865.5 851.1 861.2 863.7 866.0 866.0 912.1 913.4 913.6 914.2 914.8 729.6 738.3 899.9 904.3 913.5 663.2 665.2 665.9 669.0 674.2 14883.8 14944.2 14971.6 14980.0 15009.3 12395.8 12654.6 12778.3 12789.2 12895.5 10134.1 10150.3 10176.7 10337.1 10964.9 3441.8 3508.3 3580.6 3620.2 3635.2 72953.0 74320.0 74800.5 83438.0 85275.6 9669.1 9688.8 9737.0 9894.2 9942.9 21246.3 21277.6 21297.0 21319.7 21366.6 7709.2 7769.2 7802.0 7836.6 7911.8 4160.9 4164.5 4172.9 4235.1 4244.8 3512.7 3563.4 3565.1 3566.0 3567.6 647.6 656.0 657.8 664.0 665.2 553.5 599.5 625.9 627.4 631.6 8618.5 8652.7 8761.2 8815.2 9037.4 423.7 506.7 517.2 581.8 615.3 3130.8 3982.5 4275.2 4349.5 4378.8 71162.6 87111.8 87610.8 88754.0 88900.6 69322.3 69718.0 69771.7 70054.9 71980.0 70194.6 70475.3 71381.0 71477.6 71664.6 8895.8 8986.9 8989.8 9079.2 9104.9 48664.3 49290.8 49635.8 50854.7 51150.2 66529.7 67434.0 67865.7 68432.7 69641.0 11045.9 11105.5 11187.9 11200.8 11568.8 11995.5 12110.1 12133.4 12171.8 12899.0 11475.9 11730.8 11824.7 11843.2 12151.2 11439.1 11697.4 11900.9 11903.5 11969.8 6960.4 10981.3 11361.4 11398.7 12233.0 9637.0 9757.2 9801.7 9829.7 9845.7 9705.3 9713.3 9736.8 9738.4 9747.5 08:28:43 INFO - PROCESS | 2586 | -------- Summary: end -------- 08:28:43 INFO - PROCESS | 2586 | 08:28:44 INFO - TEST-INFO | 2586: exit 0 08:28:44 INFO - TEST-OK | dromaeo_css | took 1113601ms 08:28:44 INFO - TEST-START | kraken 08:28:44 INFO - operating with platform_type : mac_ 08:28:44 INFO - Initialising browser for kraken test... 08:28:44 INFO - TEST-INFO | started process 2588 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmppN4W8w/profile http://localhost:58632/getInfo.html) 08:28:46 INFO - PROCESS | 2588 | __metrics Screen width/height:1600/1200 08:28:46 INFO - PROCESS | 2588 | colorDepth:24 08:28:46 INFO - PROCESS | 2588 | Browser inner width/height: 1024/689 08:28:46 INFO - PROCESS | 2588 | __metrics 08:28:46 INFO - PROCESS | 2588 | 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" 08:28:46 INFO - PROCESS | 2588 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:28:46 INFO - TEST-INFO | 2588: exit 0 08:28:46 INFO - Browser initialized. 08:28:46 INFO - Running cycle 1/1 for kraken test... 08:28:46 INFO - TEST-INFO | started process 2590 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmppN4W8w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:28:58 INFO - PROCESS | 2590 | RSS: Main: 246984704 08:28:58 INFO - PROCESS | 2590 | 08:29:01 INFO - PROCESS | 2590 | Cycle 1(1): loaded http://localhost:58632/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58632/tests/kraken/driver.html?testName=audio-beat-detection) 08:29:02 INFO - PROCESS | 2590 | RSS: Main: 292298752 08:29:02 INFO - PROCESS | 2590 | 08:29:04 INFO - PROCESS | 2590 | Cycle 1(1): loaded http://localhost:58632/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58632/tests/kraken/driver.html?testName=audio-dft) 08:29:05 INFO - PROCESS | 2590 | RSS: Main: 302714880 08:29:05 INFO - PROCESS | 2590 | 08:29:08 INFO - PROCESS | 2590 | Cycle 1(1): loaded http://localhost:58632/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58632/tests/kraken/driver.html?testName=audio-fft) 08:29:09 INFO - PROCESS | 2590 | RSS: Main: 287772672 08:29:09 INFO - PROCESS | 2590 | 08:29:11 INFO - PROCESS | 2590 | Cycle 1(1): loaded http://localhost:58632/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58632/tests/kraken/driver.html?testName=audio-oscillator) 08:29:11 INFO - PROCESS | 2590 | RSS: Main: 289804288 08:29:11 INFO - PROCESS | 2590 | 08:29:14 INFO - PROCESS | 2590 | Cycle 1(1): loaded http://localhost:58632/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58632/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:29:14 INFO - PROCESS | 2590 | RSS: Main: 288628736 08:29:14 INFO - PROCESS | 2590 | 08:29:17 INFO - PROCESS | 2590 | Cycle 1(1): loaded http://localhost:58632/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58632/tests/kraken/driver.html?testName=imaging-darkroom) 08:29:17 INFO - PROCESS | 2590 | RSS: Main: 288223232 08:29:17 INFO - PROCESS | 2590 | 08:29:20 INFO - PROCESS | 2590 | Cycle 1(1): loaded http://localhost:58632/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58632/tests/kraken/driver.html?testName=imaging-desaturate) 08:29:21 INFO - PROCESS | 2590 | RSS: Main: 290201600 08:29:21 INFO - PROCESS | 2590 | 08:29:23 INFO - PROCESS | 2590 | Cycle 1(1): loaded http://localhost:58632/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58632/tests/kraken/driver.html?testName=json-parse-financial) 08:29:24 INFO - PROCESS | 2590 | RSS: Main: 290082816 08:29:24 INFO - PROCESS | 2590 | 08:29:26 INFO - PROCESS | 2590 | Cycle 1(1): loaded http://localhost:58632/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58632/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:29:26 INFO - PROCESS | 2590 | RSS: Main: 323497984 08:29:26 INFO - PROCESS | 2590 | 08:29:28 INFO - PROCESS | 2590 | Cycle 1(1): loaded http://localhost:58632/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58632/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:29:29 INFO - PROCESS | 2590 | RSS: Main: 324247552 08:29:29 INFO - PROCESS | 2590 | 08:29:31 INFO - PROCESS | 2590 | Cycle 1(1): loaded http://localhost:58632/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58632/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:29:31 INFO - PROCESS | 2590 | RSS: Main: 334286848 08:29:31 INFO - PROCESS | 2590 | 08:29:34 INFO - PROCESS | 2590 | Cycle 1(1): loaded http://localhost:58632/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58632/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:29:35 INFO - PROCESS | 2590 | RSS: Main: 336277504 08:29:35 INFO - PROCESS | 2590 | 08:29:37 INFO - PROCESS | 2590 | Cycle 1(1): loaded http://localhost:58632/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58632/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:29:38 INFO - PROCESS | 2590 | RSS: Main: 335523840 08:29:38 INFO - PROCESS | 2590 | 08:29:39 INFO - PROCESS | 2590 | Cycle 1(1): loaded http://localhost:58632/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58632/tests/kraken/driver.html?testName=ai-astar) 08:29:40 INFO - PROCESS | 2590 | RSS: Main: 396509184 08:29:40 INFO - PROCESS | 2590 | 08:29:40 INFO - PROCESS | 2590 | __start_tp_report 08:29:40 INFO - PROCESS | 2590 | _x_x_mozilla_page_load 08:29:40 INFO - PROCESS | 2590 | _x_x_mozilla_page_load_details 08:29:40 INFO - PROCESS | 2590 | |i|pagename|runs| 08:29:40 INFO - PROCESS | 2590 | |0;ai-astar;110;108;111;110;111;117;164;163;110;111 08:29:40 INFO - PROCESS | 2590 | |1;audio-beat-detection;177;153;169;155;121;141;139;118;154;121 08:29:40 INFO - PROCESS | 2590 | |2;audio-dft;188;184;186;185;199;264;186;187;183;183 08:29:40 INFO - PROCESS | 2590 | |3;audio-fft;84;94;119;108;58;56;58;79;78;76 08:29:40 INFO - PROCESS | 2590 | |4;audio-oscillator;92;99;128;78;82;80;113;77;78;114 08:29:40 INFO - PROCESS | 2590 | |5;imaging-gaussian-blur;84;93;84;89;84;89;83;89;84;89 08:29:40 INFO - PROCESS | 2590 | |6;imaging-darkroom;93;93;93;92;92;93;92;93;93;92 08:29:40 INFO - PROCESS | 2590 | |7;imaging-desaturate;86;85;88;88;89;87;87;87;87;84 08:29:40 INFO - PROCESS | 2590 | |8;json-parse-financial;56;56;53;54;53;54;54;64;53;53 08:29:40 INFO - PROCESS | 2590 | |9;json-stringify-tinderbox;62;69;71;74;69;67;67;67;67;67 08:29:40 INFO - PROCESS | 2590 | |10;stanford-crypto-aes;84;83;84;81;82;83;79;101;105;109 08:29:40 INFO - PROCESS | 2590 | |11;stanford-crypto-ccm;128;130;111;129;126;128;128;119;122;120 08:29:40 INFO - PROCESS | 2590 | |12;stanford-crypto-pbkdf2;134;126;136;136;137;124;136;139;137;137 08:29:40 INFO - PROCESS | 2590 | |13;stanford-crypto-sha256-iterative;57;81;96;94;68;67;68;68;67;65 08:29:40 INFO - PROCESS | 2590 | __end_tp_report 08:29:40 INFO - PROCESS | 2590 | __start_cc_report 08:29:40 INFO - PROCESS | 2590 | _x_x_mozilla_cycle_collect,1175 08:29:40 INFO - PROCESS | 2590 | __end_cc_report 08:29:40 INFO - PROCESS | 2590 | __startTimestamp1455121780124__endTimestamp 08:29:40 INFO - PROCESS | 2590 | 08:29:40 INFO - PROCESS | 2590 | ------- Summary: start ------- 08:29:40 INFO - PROCESS | 2590 | Number of tests: 14 08:29:40 INFO - PROCESS | 2590 | 08:29:40 INFO - PROCESS | 2590 | [#0] ai-astar Cycles:10 Average:121.50 Median:111.00 stddev:22.26 (20.1%) stddev-sans-first:23.22 08:29:40 INFO - PROCESS | 2590 | Values: 110.0 108.0 111.0 110.0 111.0 117.0 164.0 163.0 110.0 111.0 08:29:40 INFO - PROCESS | 2590 | 08:29:40 INFO - PROCESS | 2590 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:153.50 stddev:20.49 (13.3%) stddev-sans-first:18.12 08:29:40 INFO - PROCESS | 2590 | Values: 177.0 153.0 169.0 155.0 121.0 141.0 139.0 118.0 154.0 121.0 08:29:40 INFO - PROCESS | 2590 | 08:29:40 INFO - PROCESS | 2590 | [#2] audio-dft Cycles:10 Average:194.50 Median:186.50 stddev:24.85 (13.3%) stddev-sans-first:26.25 08:29:40 INFO - PROCESS | 2590 | Values: 188.0 184.0 186.0 185.0 199.0 264.0 186.0 187.0 183.0 183.0 08:29:40 INFO - PROCESS | 2590 | 08:29:40 INFO - PROCESS | 2590 | [#3] audio-fft Cycles:10 Average:81.00 Median:77.00 stddev:21.27 (27.6%) stddev-sans-first:22.53 08:29:40 INFO - PROCESS | 2590 | Values: 84.0 94.0 119.0 108.0 58.0 56.0 58.0 79.0 78.0 76.0 08:29:40 INFO - PROCESS | 2590 | 08:29:40 INFO - PROCESS | 2590 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:79.00 stddev:18.52 (23.4%) stddev-sans-first:19.63 08:29:40 INFO - PROCESS | 2590 | Values: 92.0 99.0 128.0 78.0 82.0 80.0 113.0 77.0 78.0 114.0 08:29:40 INFO - PROCESS | 2590 | 08:29:40 INFO - PROCESS | 2590 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:89.00 stddev:3.39 (3.8%) stddev-sans-first:3.44 08:29:40 INFO - PROCESS | 2590 | Values: 84.0 93.0 84.0 89.0 84.0 89.0 83.0 89.0 84.0 89.0 08:29:40 INFO - PROCESS | 2590 | 08:29:40 INFO - PROCESS | 2590 | [#6] imaging-darkroom Cycles:10 Average:92.60 Median:93.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 08:29:40 INFO - PROCESS | 2590 | Values: 93.0 93.0 93.0 92.0 92.0 93.0 92.0 93.0 93.0 92.0 08:29:40 INFO - PROCESS | 2590 | 08:29:40 INFO - PROCESS | 2590 | [#7] imaging-desaturate Cycles:10 Average:86.80 Median:87.00 stddev:1.48 (1.7%) stddev-sans-first:1.54 08:29:40 INFO - PROCESS | 2590 | Values: 86.0 85.0 88.0 88.0 89.0 87.0 87.0 87.0 87.0 84.0 08:29:40 INFO - PROCESS | 2590 | 08:29:40 INFO - PROCESS | 2590 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:54.00 stddev:3.37 (6.2%) stddev-sans-first:3.55 08:29:40 INFO - PROCESS | 2590 | Values: 56.0 56.0 53.0 54.0 53.0 54.0 54.0 64.0 53.0 53.0 08:29:40 INFO - PROCESS | 2590 | 08:29:40 INFO - PROCESS | 2590 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:3.13 (4.6%) stddev-sans-first:2.45 08:29:40 INFO - PROCESS | 2590 | Values: 62.0 69.0 71.0 74.0 69.0 67.0 67.0 67.0 67.0 67.0 08:29:40 INFO - PROCESS | 2590 | 08:29:40 INFO - PROCESS | 2590 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:82.50 stddev:11.23 (13.6%) stddev-sans-first:11.76 08:29:40 INFO - PROCESS | 2590 | Values: 84.0 83.0 84.0 81.0 82.0 83.0 79.0 101.0 105.0 109.0 08:29:40 INFO - PROCESS | 2590 | 08:29:40 INFO - PROCESS | 2590 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:128.00 stddev:6.03 (4.7%) stddev-sans-first:6.22 08:29:40 INFO - PROCESS | 2590 | Values: 128.0 130.0 111.0 129.0 126.0 128.0 128.0 119.0 122.0 120.0 08:29:40 INFO - PROCESS | 2590 | 08:29:40 INFO - PROCESS | 2590 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.20 Median:136.50 stddev:5.03 (3.7%) stddev-sans-first:5.33 08:29:40 INFO - PROCESS | 2590 | Values: 134.0 126.0 136.0 136.0 137.0 124.0 136.0 139.0 137.0 137.0 08:29:40 INFO - PROCESS | 2590 | 08:29:40 INFO - PROCESS | 2590 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:68.00 stddev:12.91 (19.0%) stddev-sans-first:12.31 08:29:40 INFO - PROCESS | 2590 | Values: 57.0 81.0 96.0 94.0 68.0 67.0 68.0 68.0 67.0 65.0 08:29:40 INFO - PROCESS | 2590 | -------- Summary: end -------- 08:29:40 INFO - PROCESS | 2590 | 08:29:40 INFO - TEST-INFO | 2590: exit 0 08:29:40 INFO - TEST-OK | kraken | took 56772ms 08:29:40 INFO - SUITE-END | took 1170s 08:29:41 INFO - Completed test suite (00:19:30) 08:29:41 INFO - Working with test: dromaeo_css 08:29:41 INFO - Generating results file: dromaeo_css 08:29:41 INFO - Working with test: kraken 08:29:41 INFO - Generating results file: kraken 08:29:41 INFO - javascript benchmark 08:29:41 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:29:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 08:29:41 INFO - process_Request line: dromaeo_css 7634.67 graph.html#tests=[[72,64,59]] 08:29:41 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:29:41 INFO - process_Request line: kraken 1445.60 graph.html#tests=[[232,64,59]] 08:29:41 INFO - RETURN: dromaeo_css: 7634.67 08:29:41 INFO - RETURN: kraken: 1445.60 08:29:41 INFO - javascript benchmark 08:29:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3013.969860301397, 3423.469362248852, 3429.262708517669, 3439.4496880499123, 3483.4426491761324, 5534.4742249486235, 5608.6073974821775, 5632.211490391349, 5651.5761317901115, 5674.063779476387, 5639.7180140993, 5649.293838270216, 5725.2843394575675, 5783.768649254025, 5792.768289268424, 5049.84850454487, 5079.085764562377, 5100.693958362492, 5117.462666420028, 5213.58291336694, 5192.065428222918, 5215.817446389377, 5234.476552344754, 5249.658772179815, 5283.445238249986, 5065.873353166182, 5083.593312534988, 5148.459411761786, 5161.509656582619, 5180.45605211453, 5120.359955005624, 5153.072446959546, 5159.58723302135, 5170.146925757245, 5181.844544663666, 5070.822521211777, 5095.643304968654, 5115.948840511584, 5120.692758434506, 5153.948460515385, 5478.58910581704, 5573.247611572427, 5604.887902241973, 5614.438556144394, 5643.746031428595, 6091.72073864489, 6197.318294987548, 6201.379862013808, 6209.6895155242055, 6216.471599914013, 6171.814845554641, 6202.627842329474, 6213.409726076015, 6222.12890195373, 6222.284437289724, 5640.971795141039, 5711.544036064491, 5725.198472213893, 5726.627769194989, 5735.254416925773, 6247.437730604177, 6247.812565623039, 6263.029230469285, 6269.874602508015, 6273.278572964076, 5986.551008674367, 5999.790007349722, 6044.486218671462, 6061.787837425669, 6066.272047354346, 6057.303410107806, 6117.796956032686, 6127.556056270569, 6201.224846894138, 6242.438180563771, 5806.68063256525, 6136.417040381157, 6145.754169833246, 6151.384861513813, 6169.907451388232, 6170.950938340493, 6176.413240742122, 6187.84530386744, 6209.006558950547, 6220.782272620437, 4774.4509381421585, 4823.348847905558, 4834.274858771142, 4835.323054772335, 4849.563539281482, 4338.76136812472, 4343.478782546114, 4397.406350142754, 4423.447069116361, 4459.687821852439, 5584.457690101488, 5597.6641401516035, 5622.493975542221, 5635.21107045014, 5639.069553523623, 6239.407256310643, 6252.531060170505, 6266.811995640138, 6274.529410294246, 6281.434670879643, 5439.809606663748, 5574.247476590689, 5593.105103183471, 5629.662220266797, 5659.660420374791, 5316.46835316473, 5325.227841962894, 5330.946690533123, 5331.200319952039, 5333.120035194227, 6169.598976066542, 6257.374262573706, 6275.466585340298, 6282.905756413657, 6284.811455656338, 6116.031445915052, 6118.785842495491, 6144.53915956314, 6209.5032397409, 6223.688815559294, 6165.84585385351, 6245.250569931637, 6282.1519094921605, 6295.276043255084, 6300.464460520907, 6123.510119190543, 6124.173236613, 6124.785632502841, 6138.0, 6139.4781443577795, 6219.160413344322, 6241.531885108544, 6241.906371404341, 6251.093591429309, 6259.34276900937, 5134.435212126588, 5907.084401917709, 5981.910271346021, 5990.880182396415, 6044.667543285162, 5950.3454619992635, 5968.343482217039, 5971.373005834324, 5974.283086029531, 5999.790007349722, 5723.8569035774435, 5773.653580785166, 5793.304803423616, 5801.912971305518, 5803.7968671096305, 5792.899349123653, 5937.109433584997, 5952.404759524186, 5959.910601340896, 5960.821175364746, 5049.293098966221, 5774.48029677331, 5908.615939963888, 5912.408759124053, 5912.46787789101], "unit": "score", "name": "dojo.html", "value": 5628.410417459107}, {"lowerIsBetter": false, "replicates": [485.06866815713823, 492.89649173673524, 575.3814649252053, 579.2527639345245, 617.05282391529, 28835.134945951628, 36960.630393696054, 37528.43707344392, 37665.62334376655, 37759.62240377599, 39737.0, 39886.20227595446, 39902.40146397799, 40000.79997600069, 40040.79979600098, 9426.858597121032, 9647.758806029835, 9650.806983860319, 9656.565454554562, 9670.032996700344, 9503.334766566342, 9612.231021518297, 9647.228221742278, 9651.5174241288, 9734.65928692496, 9703.369280996749, 9784.755381115494, 9790.951045244763, 9791.363561368524, 9831.410115393064, 8290.668373265062, 9680.225581953462, 9727.610895564168, 9735.90264097357, 9773.21814254858, 9507.809843803085, 9629.085236902552, 9644.276679249015, 9645.08371704687, 9660.90339096607, 38376.808115959524, 38791.22417551661, 38799.61200387988, 38880.805595972124, 39270.803645981876, 3162.667919868427, 3348.8808765218673, 3361.478970759536, 3531.2407832315916, 3746.662800347982, 26208.8689556551, 27021.0, 28182.577261341095, 28185.013524526545, 28295.292617684518, 2716.4838680650614, 2730.4675588260297, 2822.943541129166, 2857.1857020748985, 2869.4834929712642, 384483.0, 472838.0, 473543.0, 474312.0, 477948.9999999965, 52135.739321303154, 63329.68335158295, 63501.09496715106, 63501.68249158817, 63506.0, 67189.0, 67212.32787672158, 67417.98873016909, 67498.32501675018, 67563.98654020193, 15742.212889355487, 15821.288042038135, 15834.366625334858, 15951.601209969844, 16064.919675401781, 12278.631641050782, 12362.75274494505, 12367.752644947052, 12385.504579816887, 12386.690332741753, 19380.321688740827, 20147.19411223564, 20159.891205983517, 20185.192592296436, 20237.98810059491, 7345.77962661121, 8588.65645374178, 8881.911180888108, 8888.644454221889, 8896.377253592187, 936.2089034765748, 937.7139972308512, 942.9434233945985, 1019.9541020654088, 1165.953361865516, 28388.081895799205, 29315.0, 29361.412771744872, 29579.704202958124, 30397.0, 1007.4660429972126, 1042.551702767802, 1086.5653738504504, 1108.972275693098, 1168.1705988748083, 12703.42834572428, 15053.623659408602, 15752.0, 15813.68372632541, 15855.52433426999, 641207.0, 645115.0, 646380.0, 646615.7669211624, 648978.0, 54124.0, 54606.90786184254, 54660.453395466335, 54796.17805732917, 54937.175942360096, 1232.6733415644862, 1410.739013282546, 1456.4319915233068, 1456.5557504960877, 1457.5190187237974, 29470.557941630464, 30588.235294117825, 31108.0, 31255.218619534695, 31911.0, 51828.222576662134, 52498.73750631222, 52525.47474525359, 52531.73734131305, 52538.21192682036, 471381.0, 476922.0, 478922.0, 479100.0, 480066.0, 41190.58809411868, 41780.58219417767, 42155.789221053696, 42326.36510452284, 42376.0, 43774.562254378325, 43929.0, 44434.0, 44834.0, 45198.0, 28551.14346569523, 31370.0, 32079.0, 34803.477947830295, 35190.472142917366, 33476.33047339088, 33677.49483757795, 33715.494267586495, 34112.82943585266, 34166.487502686985, 33556.98662576649, 34148.487772683926, 34216.82891585526, 34529.654703452645, 34544.0, 23663.17178898799, 30546.389072218877, 32857.028738042725, 33216.50175247325, 33396.833015835735, 24511.50976980486, 24719.752802471747, 24847.50304993854, 24878.626820597343, 25042.37394065163], "unit": "score", "name": "ext.html", "value": 19713.99891570383}, {"lowerIsBetter": false, "replicates": [311.5995945210405, 361.13868423809214, 364.2405584356616, 366.490578096446, 370.298284750398, 18501.074946252684, 18682.06589670518, 19385.418437446882, 20000.0999955002, 20037.298694545694, 13925.442982280696, 15413.3834646614, 18935.0, 19928.601427971433, 19936.0, 5830.7084645767645, 6237.563370564062, 6381.1066450696935, 6442.16251887254, 6449.322821103787, 4492.3710680504755, 6333.271673757507, 6467.0, 6471.579347342431, 6472.676366181696, 4673.135469938073, 4685.180093483644, 4685.60172385346, 4686.27362758773, 6951.930480695204, 7011.158660960667, 7131.3938315243, 7219.602921839297, 7231.783046508614, 7265.1645060818155, 6793.354631310018, 6871.209810871714, 6873.828154296132, 6877.449804015667, 6893.517453778238, 25206.747932520622, 25262.0, 25301.49397012068, 26145.0, 26196.476070478482, 2272.6931864198286, 2294.9426264343356, 2315.30540837748, 2328.172270883982, 2460.6801115855005, 14805.0, 14928.566429721224, 15216.163111028889, 15335.079895206323, 15821.525354239277, 1835.85313174947, 1853.2216469083016, 1856.7400563921062, 1893.0061717598232, 1895.2134864031411, 105513.47243263734, 109643.0, 109907.0, 110064.0, 111103.0, 18072.457826265232, 18355.56420505296, 18482.81517184838, 18500.629987400178, 18542.25830966746, 21811.781882180974, 26311.73688263131, 26316.473670526484, 26860.865695671397, 26911.596326055125, 9218.492982886006, 9770.804583908282, 10130.0, 10182.338148020355, 10186.949065254626, 8632.482051076955, 8637.611307491177, 8672.783180420414, 8702.738917832476, 8735.908011498563, 8326.625301861432, 8356.874646880302, 8462.661493540189, 8476.194761497647, 8486.40595158333, 2773.62556054934, 3332.8166950817454, 3339.3655205510877, 3371.6291207967106, 3378.493226016117, 827.1149869639548, 849.180540778152, 883.1477624092653, 945.9905400946041, 1049.6011515624014, 14579.781303280459, 16344.598282963578, 19720.506987325145, 20250.291239806535, 20296.898515507623, 938.7887725261761, 969.0842154164247, 975.2198241406846, 976.1848856205006, 1034.9793004140026, 10291.794164116676, 10511.737206569896, 10528.947355263328, 10543.472826358651, 10556.944305569381, 583533.0, 698158.0, 714219.0, 721815.0, 731758.0, 118741.49371594399, 120566.39716801535, 122155.0, 123528.0, 127541.36229318794, 1146.6388087752332, 1160.6924165096257, 1181.2203945395997, 1183.4496958913974, 1186.4127257007835, 17330.82669173292, 17473.912630437277, 17570.945743255445, 17635.911820440815, 17890.10549472547, 40847.0, 47880.521194789, 48052.7597362025, 49110.754446228966, 51532.74233628808, 67608.0, 69001.0, 69707.25731856744, 70218.0, 70672.29327706863, 7493.550386976799, 7758.612069396395, 7832.942552755305, 7842.843143136991, 7845.725399610987, 9387.85918211241, 11800.0, 11897.702557436134, 11915.642530724092, 12332.07509436778, 9493.288003399635, 9605.519724013631, 10036.096751292418, 10429.530671119666, 10620.628278010232, 10049.547770350498, 10481.318714283547, 10517.631882884063, 10571.36571805694, 10605.363678179334, 4540.72755634663, 7613.7437322843325, 10376.481175941324, 10524.947375263075, 10691.732706682084, 6307.684615769102, 7611.0, 7781.688732450639, 7792.688292468464, 7853.09689385728, 9956.153726933291, 10004.699859004242, 10774.892251077388, 10820.945895270474, 10990.505427255634], "unit": "score", "name": "jquery.html", "value": 10112.79720312384}, {"lowerIsBetter": false, "replicates": [1378.744932187546, 1501.2343704710597, 1519.3087145348868, 1743.7122874725671, 1923.0, 7981.76054718358, 8611.44025638334, 8879.733607991755, 8881.555922203881, 8883.955580222106, 8413.284870785976, 8676.566171691406, 8680.392372533925, 8689.695860644879, 8695.217430431276, 2156.6657168138886, 2221.7889300516426, 2482.205694177859, 2505.285993491855, 2508.6237064440297, 2477.492114116602, 2532.8353657012326, 2534.214393538009, 2535.871537165962, 2537.3656585853537, 2422.4549476367765, 2497.5504409206337, 2503.3616427810975, 2504.098524531167, 2505.4112283613335, 2454.3864033991504, 2477.578811602032, 2510.1967370441466, 2511.7739403453593, 2515.320863366899, 2464.938376540583, 2491.377155711072, 2493.551160791057, 2517.0686845867144, 2522.041624182799, 8920.598573064228, 8956.417832840845, 8992.77518062047, 8994.730158095268, 9007.909920900838, 5403.7027963462, 5549.38956714761, 5561.0, 5561.4716601922755, 5567.749451274703, 3653.671169594723, 3684.336819372512, 3760.5863355031197, 3771.528558930134, 3781.6785573226307, 1050.3172937590627, 1061.5435362793996, 1062.516554967488, 1091.939943303118, 1100.5542755184163, 12239.69400764988, 12265.0, 12266.0, 12272.852250856064, 12274.815877761841, 4942.1104201244125, 4958.628102892298, 4985.700857948535, 5054.873628159326, 5066.873328166826, 10363.792724145474, 10368.792624147625, 10372.585096596202, 10377.429241391796, 10400.47997600117, 5584.497395234367, 5586.385497595261, 5588.0, 5588.050031494656, 5598.552115830724, 4928.457869634337, 5047.293378926953, 5063.11395505785, 5065.822696205615, 5070.087384270793, 3696.9075773105887, 3769.9246015080093, 3909.706771992112, 3976.304146774303, 3992.281389349887, 997.8823717436518, 1093.3767752381225, 1260.174585646403, 1311.3312210772574, 1329.322045756671, 1284.9229046257256, 1291.8514370847286, 1302.4724986380531, 1316.394458549059, 1345.7039451320693, 8105.918940810634, 8204.425690201748, 8222.218889205516, 8269.669213231524, 8299.460535065202, 1167.445463404876, 1173.3253379306932, 1176.5940750441255, 1177.2112684501406, 1193.2303664136584, 6267.4045965633195, 6360.936390636127, 6369.904451433232, 6374.808755737336, 6376.936230637727, 10366.326188797855, 10537.9473102634, 10588.841167382496, 10727.892721072845, 10743.677689669323, 8794.296456283482, 10248.282620216512, 10569.841452378221, 10574.154067674568, 10640.308379955279, 8302.0, 8430.789230269293, 8433.241008309282, 8434.74695759116, 8441.113683063313, 8081.353491720531, 8089.595520223847, 8186.304164146114, 8195.508269503849, 8372.623231954454, 9622.9037709622, 9914.107730304308, 9946.45294508809, 9960.053794889764, 10066.54700538463, 10021.599136034478, 10204.438755868201, 10472.0, 10477.790444190921, 10506.15950723925, 7546.584937828472, 7602.239776022354, 7605.6577454013595, 7644.655990480553, 7697.384209263134, 7586.848263034819, 7783.805404864697, 8190.099089100075, 8335.291500222549, 8370.204830541088, 7138.786406310835, 7361.2638736125955, 7764.029496312961, 7881.369490440637, 8034.959825200836, 7729.884051739116, 7735.342495887688, 7773.533587984739, 7819.530828150329, 7844.4901081429525, 7871.212878712312, 7928.246816552418, 7930.643121059451, 7937.126916039116, 7938.682452701827, 7066.293370663098, 7099.148102227766, 7133.0, 7154.713811447484, 7164.283571642794, 7202.96398518004, 7259.455540834564, 7261.201267860425, 7276.163241227327, 7276.781696549112], "unit": "score", "name": "mootools.html", "value": 5020.24747284263}, {"lowerIsBetter": false, "replicates": [310.20896713380904, 323.1726779444622, 328.6089553431418, 332.7537622159602, 336.7020187134387, 6612.140421745178, 6624.403803657669, 6635.137432133822, 6649.800505984822, 6671.199456065273, 6541.901871471931, 6580.177477815273, 6584.539082264243, 6597.0, 6637.0, 4882.780274887638, 4902.65681402302, 4906.975465122669, 4913.680610760289, 4923.015396920612, 4643.396358473394, 4804.279358096279, 4810.158222311082, 4810.182269014258, 4812.446568644616, 4730.62155027597, 4746.715197088169, 4753.524647535253, 4762.166620841356, 4771.308160316752, 3875.9147438717205, 4585.656075794295, 4728.054389122155, 4742.359781429497, 4751.311059896313, 4008.4388185654034, 4017.216642754664, 4017.578154293786, 4025.0943537704075, 4027.3153563894207, 6062.727177276989, 6281.842953926142, 6321.336259692712, 6369.9171140906155, 6373.521985851034, 5612.186232996192, 5630.887382252373, 5636.464535869086, 5643.125315576051, 5650.208970744099, 6655.500837437212, 6762.560433571802, 7059.964700176518, 7060.717571297142, 7071.823204419879, 4518.615917647004, 4556.635469162459, 4558.293464513005, 4579.63362930968, 4586.128635559233, 6037.78867739627, 7319.890201646979, 7366.5948372839475, 7395.2235015323695, 7416.740414085535, 4594.241950078266, 4609.400777898919, 4627.051454451829, 4629.120467111238, 4630.791614377361, 4674.415698037746, 4687.859364219079, 4691.038337140878, 4701.224297990793, 4702.858914232578, 5308.150695888639, 5380.650257733235, 5395.541378982831, 5397.595180361489, 5403.891922161613, 6007.098935159761, 6839.555428897106, 6844.726210951606, 6937.271586483447, 7005.824854378681, 1594.2666373468103, 1614.7254966655696, 1615.5234205909285, 1616.692828362631, 1617.44198251603, 908.3459908865606, 986.1716158426813, 1031.742064483879, 1053.489057806963, 1057.259918057363, 6509.0, 6547.476201903836, 6600.405963463311, 6600.900986485207, 6605.405513503808, 7309.232530584319, 7311.634418279064, 7316.670749816271, 7342.4493163012985, 7349.889751653729, 6417.614943103429, 6572.901406478906, 6578.177727784027, 6598.637074960827, 6608.207015158212, 3247.707706306444, 3772.6607054495807, 3871.457995880579, 3872.4191371294532, 3874.244522318177, 7557.773266802004, 7574.166841647414, 7576.962115189499, 7581.052368453943, 7586.696532138763, 6396.136521569621, 7157.284271572905, 7221.566705997657, 7390.371818395389, 7538.3592394645975, 7557.093148822177, 7594.886076708854, 7606.885896711443, 7612.885806712904, 7621.923780762232, 7249.238829922993, 7261.745838895613, 7263.745768898063, 7280.381167600814, 7291.854162916606, 7002.323780015533, 7132.646226745058, 7312.597807120659, 7333.266673332624, 7334.486585938933, 7701.768946931601, 7710.421718371257, 7729.690812367442, 7736.381089512938, 7738.303552680286, 4666.486686464554, 4699.553542413465, 4709.0, 4713.764311784328, 4718.245080787057, 7078.362947334765, 7173.246809084971, 7270.382017528569, 7387.7783666490095, 7413.666385012795, 6962.268961758942, 7056.15326160864, 7122.358987691133, 7142.892856607259, 7168.426525877813, 7130.7147714092935, 7158.141023077056, 7172.282771722995, 7178.856422871618, 7184.9640751798, 5981.0, 6743.35938085881, 6929.3070692930305, 6947.5831450113155, 6954.478414119062, 7098.574085554883, 7104.964475177591, 7113.110861142357, 7113.893291600527, 7125.251848556034, 6815.591064535945, 6925.826854328682, 6962.721491140298, 6966.1988871280455, 6973.093497845248], "unit": "score", "name": "prototype.html", "value": 5115.240863136372}, {"lowerIsBetter": false, "replicates": [657.3262406033815, 667.71955778573, 669.9966500167499, 745.9030326057612, 762.8512440074185, 14426.855731442696, 14627.707445851076, 14645.267736613167, 14652.120872747615, 14679.559613211593, 15094.018888772249, 15447.845521544781, 15476.226188690549, 15476.226188690549, 15497.302621382036, 694.2467422846217, 700.6181631011111, 829.7593697827638, 859.896812382515, 865.5412631305418, 851.059579165023, 861.1689719420789, 863.7236084452977, 866.0084203586889, 866.0343716755835, 912.0605776050678, 913.3880300198882, 913.6025828764475, 914.1863741270275, 914.8444764390036, 729.5804912175494, 738.3318097122113, 899.9145081217274, 904.3082042237694, 913.5295322908707, 663.1677245057422, 665.218368417108, 665.8634979829123, 669.0132055218562, 674.2078058281548, 14883.776743348859, 14944.178070206135, 14971.625709357244, 14980.0, 15009.324580393908, 12395.75208495825, 12654.55709050188, 12778.297193654345, 12789.168704034208, 12895.484180632764, 10134.13859821916, 10150.340227885164, 10176.745581360452, 10337.0696637303, 10964.890351096547, 3441.82790860456, 3508.333416650828, 3580.6240344763687, 3620.2216523447587, 3635.182084031072, 72953.0, 74320.0, 74800.5039899199, 83438.0, 85275.57362213211, 9669.081437263449, 9688.806223875483, 9736.95131524338, 9894.158996485236, 9942.850857237147, 21246.25638102659, 21277.574448510943, 21297.0, 21319.65483796781, 21366.572668546854, 7709.151993280735, 7769.223077692299, 7802.0, 7836.608169591497, 7911.84176316482, 4160.895977600524, 4164.5210800758305, 4172.937405938914, 4235.131797981407, 4244.830206791756, 3512.7014203792965, 3563.3585954527916, 3565.0552603560077, 3566.0193446802336, 3567.5897271813556, 647.5531883000715, 656.0127008851648, 657.8421178917025, 664.0371461381017, 665.1585744033802, 553.5212041584001, 599.5293694449836, 625.9499240060875, 627.3569591169088, 631.5579094633774, 8618.482891026559, 8652.740417787476, 8761.211490965843, 8815.206631403076, 9037.367384283038, 423.686472010716, 506.71370675568187, 517.1725239616584, 581.8138195777395, 615.2524682510771, 3130.7808453408043, 3982.522097348337, 4275.166342563232, 4349.478062632441, 4378.846740364135, 71162.64418677874, 87111.77329360259, 87610.80972975599, 88754.0, 88900.5554972221, 69322.3067769326, 69718.0, 69771.65114174498, 70054.9491757624, 71980.0, 70194.64902675556, 70475.29524704687, 71381.0, 71477.6426117866, 71664.56670866658, 8895.777605559913, 8986.86519702192, 8989.775255618662, 9079.24494390985, 9104.863427048733, 48664.2700359502, 49290.76773080702, 49635.751821240665, 50854.7286317845, 51150.20974265883, 66529.66735166294, 67434.0, 67865.66067169633, 68432.6578367105, 69640.95538566825, 11045.944770276097, 11105.500252488819, 11187.888121118685, 11200.831987520356, 11568.762543809831, 11995.520179193083, 12110.091743119478, 12133.39333033327, 12171.817422738843, 12899.0, 11475.942620286845, 11730.824037639613, 11824.704382390164, 11843.170978031456, 12151.210171338835, 11439.08487321029, 11697.415129243675, 11900.880991189977, 11903.464344104363, 11969.760604787682, 6960.408365288805, 10981.286216395909, 11361.431928403712, 11398.658040258806, 12233.0, 9637.036296370306, 9757.219422446045, 9801.656942006995, 9829.705108846745, 9845.704628861145, 9705.272104592324, 9713.320067595201, 9736.805263894541, 9738.415695058318, 9747.512624368896], "unit": "score", "name": "yui.html", "value": 6871.979677422079}], "name": "dromaeo_css", "value": 7634.666117110184}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 108.0, 111.0, 110.0, 111.0, 117.0, 164.0, 163.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 121.5}, {"lowerIsBetter": true, "replicates": [177.0, 153.0, 169.0, 155.0, 121.0, 141.0, 139.0, 118.0, 154.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 144.8}, {"lowerIsBetter": true, "replicates": [188.0, 184.0, 186.0, 185.0, 199.0, 264.0, 186.0, 187.0, 183.0, 183.0], "unit": "score", "name": "audio-dft", "value": 194.5}, {"lowerIsBetter": true, "replicates": [84.0, 94.0, 119.0, 108.0, 58.0, 56.0, 58.0, 79.0, 78.0, 76.0], "unit": "score", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [92.0, 99.0, 128.0, 78.0, 82.0, 80.0, 113.0, 77.0, 78.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 94.1}, {"lowerIsBetter": true, "replicates": [84.0, 93.0, 84.0, 89.0, 84.0, 89.0, 83.0, 89.0, 84.0, 89.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.8}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 93.0, 92.0, 92.0, 93.0, 92.0, 93.0, 93.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 92.6}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 88.0, 88.0, 89.0, 87.0, 87.0, 87.0, 87.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 86.8}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 53.0, 54.0, 53.0, 54.0, 54.0, 64.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.0}, {"lowerIsBetter": true, "replicates": [62.0, 69.0, 71.0, 74.0, 69.0, 67.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 84.0, 81.0, 82.0, 83.0, 79.0, 101.0, 105.0, 109.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.1}, {"lowerIsBetter": true, "replicates": [128.0, 130.0, 111.0, 129.0, 126.0, 128.0, 128.0, 119.0, 122.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [134.0, 126.0, 136.0, 136.0, 137.0, 124.0, 136.0, 139.0, 137.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.2}, {"lowerIsBetter": true, "replicates": [57.0, 81.0, 96.0, 94.0, 68.0, 67.0, 68.0, 68.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 73.1}], "name": "kraken", "value": 1445.5999999999997}]} 08:29:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1445.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7634.67"}}} 08:29:41 INFO - Return code: 0 08:29:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:29:41 INFO - # TBPL SUCCESS # 08:29:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:29:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:29:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:29:41 INFO - 2016-02-10 08:29:41.841 screenresolution[2594:31609] starting screenresolution argv=screenresolution get 08:29:41 INFO - 2016-02-10 08:29:41.844 screenresolution[2594:31609] Display 0: 1600x1200x32@60 08:29:41 INFO - 2016-02-10 08:29:41.850 screenresolution[2595:31612] starting screenresolution argv=screenresolution list 08:29:41 INFO - Available Modes on Display 0 08:29:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:29:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:29:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:29:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:29:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:29:42 INFO - Intel Iris: 08:29:42 INFO - Chipset Model: Intel Iris 08:29:42 INFO - Type: GPU 08:29:42 INFO - Bus: Built-In 08:29:42 INFO - VRAM (Dynamic, Max): 1536 MB 08:29:42 INFO - Vendor: Intel (0x8086) 08:29:42 INFO - Device ID: 0x0a2e 08:29:42 INFO - Revision ID: 0x0009 08:29:42 INFO - Displays: 08:29:42 INFO - Display: 08:29:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:29:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:29:42 INFO - Display Serial Number: 1600x1200 60 08:29:42 INFO - Main Display: Yes 08:29:42 INFO - Mirror: Off 08:29:42 INFO - Online: Yes 08:29:42 INFO - Rotation: Supported 08:29:42 INFO - Return code: 0 08:29:42 INFO - Running post-action listener: _resource_record_post_action 08:29:42 INFO - Running post-run listener: _resource_record_post_run 08:29:43 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 0; Write bytes: 708335104; Read time: 0; Write time: 2499 08:29:43 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 382263808; Write bytes: 377865728; Read time: 28536; Write time: 720 08:29:43 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 0; Write bytes: 300924928; Read time: 0; Write time: 1697 08:29:43 INFO - Running post-run listener: _upload_blobber_files 08:29:43 INFO - Blob upload gear active. 08:29:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:29:43 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 08:29:43 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'] 08:29:43 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 08:29:43 INFO - (blobuploader) - INFO - Open directory for files ... 08:29:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:29:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:29:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:44 INFO - (blobuploader) - INFO - Done attempting. 08:29:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:29:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:29:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:45 INFO - (blobuploader) - INFO - Done attempting. 08:29:45 INFO - (blobuploader) - INFO - Iteration through files over. 08:29:45 INFO - Return code: 0 08:29:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:29:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:29:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/faffec4f67d75f1c64094bb38ac9b5e8c64a9d09b6853b61e08c5a2147d145d145867a0d089367c5c0bf8f6ae9d4ed20a9efaced5a0237614aac625b539c4888", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43e0ca3a9f401657a628d0154720341404723d5a9b81202249674f2036abd4e0970253a48050f8c1493ce724a2e77770c48897ffa0dd6508aa41c4d1e2758f26"} 08:29:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:29:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:29:45 INFO - Contents: 08:29:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/faffec4f67d75f1c64094bb38ac9b5e8c64a9d09b6853b61e08c5a2147d145d145867a0d089367c5c0bf8f6ae9d4ed20a9efaced5a0237614aac625b539c4888", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43e0ca3a9f401657a628d0154720341404723d5a9b81202249674f2036abd4e0970253a48050f8c1493ce724a2e77770c48897ffa0dd6508aa41c4d1e2758f26"} 08:29:45 INFO - Running post-run listener: copy_logs_to_upload_dir 08:29:45 INFO - Copying logs to upload dir... 08:29:45 INFO - mkdir: /builds/slave/test/build/upload/logs 08:29:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.140814 ========= master_lag: 2.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-10 08:29:47.921355) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 08:29:47.924464) ========= 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.rZvIbX0oOt/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.gIQ5wWsKDC/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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/faffec4f67d75f1c64094bb38ac9b5e8c64a9d09b6853b61e08c5a2147d145d145867a0d089367c5c0bf8f6ae9d4ed20a9efaced5a0237614aac625b539c4888", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43e0ca3a9f401657a628d0154720341404723d5a9b81202249674f2036abd4e0970253a48050f8c1493ce724a2e77770c48897ffa0dd6508aa41c4d1e2758f26"} build_url:https://queue.taskcluster.net/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011390 build_url: 'https://queue.taskcluster.net/v1/task/ANDvpZKIQaaOrwxU8xBTSQ/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/faffec4f67d75f1c64094bb38ac9b5e8c64a9d09b6853b61e08c5a2147d145d145867a0d089367c5c0bf8f6ae9d4ed20a9efaced5a0237614aac625b539c4888", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43e0ca3a9f401657a628d0154720341404723d5a9b81202249674f2036abd4e0970253a48050f8c1493ce724a2e77770c48897ffa0dd6508aa41c4d1e2758f26"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 08:29:47.974200) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 08:29:47.980614) ========= 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.rZvIbX0oOt/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.gIQ5wWsKDC/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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.005171 ========= master_lag: 0.17 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 08:29:48.151624) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 08:29:48.151906) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 08:29:48.152522) ========= ========= Total master_lag: 2.70 =========