builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0051 starttime: 1455126449.49 results: success (0) buildid: 20160210071115 builduid: 5eaaa41d4d634f4fbaa5509b21b94cb8 revision: ac39fba33c6d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 09:47:29.486949) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 09:47:29.487325) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 09:47:29.487618) ========= 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.cYANAosIDU/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.w9mN0LCuFV/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.005286 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 09:47:29.511724) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 09:47:29.512229) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 09:47:29.530282) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 09:47:29.530856) ========= 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.cYANAosIDU/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.w9mN0LCuFV/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.004979 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 09:47:29.581423) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 09:47:29.581717) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 09:47:29.582058) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 09:47:29.582330) ========= 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.cYANAosIDU/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.w9mN0LCuFV/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 09:47:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 147M=0s 2016-02-10 09:47:29 (147 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119637 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 09:47:29.716373) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 09:47:29.716693) ========= 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.cYANAosIDU/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.w9mN0LCuFV/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.019260 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 09:47:29.768980) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 09:47:29.769765) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ac39fba33c6d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ac39fba33c6d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cYANAosIDU/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.w9mN0LCuFV/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 09:47:29,840 Setting DEBUG logging. 2016-02-10 09:47:29,840 attempt 1/10 2016-02-10 09:47:29,840 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ac39fba33c6d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-10 09:47:30,098 unpacking tar archive at: mozilla-central-ac39fba33c6d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.501011 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 09:47:30.286470) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 09:47:30.286883) ========= echo ac39fba33c6d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ac39fba33c6d'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cYANAosIDU/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.w9mN0LCuFV/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 ac39fba33c6d program finished with exit code 0 elapsedTime=0.004701 script_repo_revision: 'ac39fba33c6d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 09:47:30.336779) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 09:47:30.337129) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 09:47:30.349338) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-02-10 09:47:30.349691) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cYANAosIDU/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.w9mN0LCuFV/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 09:47:30 INFO - MultiFileLogger online at 20160210 09:47:30 in /builds/slave/test 09:47:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:47:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:47:30 INFO - {'append_to_log': False, 09:47:30 INFO - 'base_work_dir': '/builds/slave/test', 09:47:30 INFO - 'blob_upload_branch': 'Firefox', 09:47:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:47:30 INFO - 'branch': 'Firefox', 09:47:30 INFO - 'buildbot_json_path': 'buildprops.json', 09:47:30 INFO - 'config_files': ('talos/mac_config.py',), 09:47:30 INFO - 'default_actions': ('clobber', 09:47:30 INFO - 'read-buildbot-config', 09:47:30 INFO - 'download-and-extract', 09:47:30 INFO - 'populate-webroot', 09:47:30 INFO - 'create-virtualenv', 09:47:30 INFO - 'install', 09:47:30 INFO - 'run-tests'), 09:47:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:47:30 INFO - 'download_minidump_stackwalk': True, 09:47:30 INFO - 'download_symbols': 'ondemand', 09:47:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:47:30 INFO - 'tooltool.py': '/tools/tooltool.py', 09:47:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:47:30 INFO - '/tools/misc-python/virtualenv.py')}, 09:47:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:47:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:47:30 INFO - 'installer_path': 'installer.exe', 09:47:30 INFO - 'log_level': 'info', 09:47:30 INFO - 'log_name': 'talos', 09:47:30 INFO - 'log_to_console': True, 09:47:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:47:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:47:30 INFO - 'opt_config_files': (), 09:47:30 INFO - 'pip_index': False, 09:47:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:47:30 INFO - 'cmd': ('bash', 09:47:30 INFO - '-c', 09:47:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:47:30 INFO - 'enabled': True, 09:47:30 INFO - 'halt_on_failure': False, 09:47:30 INFO - 'name': 'check_screen_resolution'},), 09:47:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:47:30 INFO - 'cmd': ('bash', 09:47:30 INFO - '-c', 09:47:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:47:30 INFO - 'enabled': True, 09:47:30 INFO - 'halt_on_failure': False, 09:47:30 INFO - 'name': 'check_screen_resolution'},), 09:47:30 INFO - 'run_cmd_checks_enabled': True, 09:47:30 INFO - 'sps_profile': False, 09:47:30 INFO - 'sps_profile_interval': 0, 09:47:30 INFO - 'suite': 'dromaeojs', 09:47:30 INFO - 'system_bits': '32', 09:47:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:47:30 INFO - 'title': 't-yosemite-r7-0051', 09:47:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:47:30 INFO - 'use_talos_json': True, 09:47:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:47:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:47:30 INFO - 'work_dir': 'build'} 09:47:30 INFO - ##### 09:47:30 INFO - ##### Running clobber step. 09:47:30 INFO - ##### 09:47:30 INFO - Running pre-action listener: _resource_record_pre_action 09:47:30 INFO - Running main action method: clobber 09:47:30 INFO - rmtree: /builds/slave/test/build 09:47:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:47:30 INFO - Running post-action listener: _resource_record_post_action 09:47:30 INFO - ##### 09:47:30 INFO - ##### Running read-buildbot-config step. 09:47:30 INFO - ##### 09:47:30 INFO - Running pre-action listener: _resource_record_pre_action 09:47:30 INFO - Running main action method: read_buildbot_config 09:47:30 INFO - Using buildbot properties: 09:47:30 INFO - { 09:47:30 INFO - "project": "", 09:47:30 INFO - "product": "firefox", 09:47:30 INFO - "script_repo_revision": "production", 09:47:30 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:47:30 INFO - "repository": "", 09:47:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:47:30 INFO - "buildid": "20160210071115", 09:47:30 INFO - "stage_platform": "macosx64", 09:47:30 INFO - "basedir": "/builds/slave/test", 09:47:30 INFO - "nightly_build": "True", 09:47:30 INFO - "buildnumber": 126, 09:47:30 INFO - "slavename": "t-yosemite-r7-0051", 09:47:30 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:47:30 INFO - "platform": "yosemite_r7", 09:47:30 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:47:30 INFO - "branch": "mozilla-central", 09:47:30 INFO - "repo_path": "mozilla-central", 09:47:30 INFO - "revision": "ac39fba33c6d", 09:47:30 INFO - "pgo_build": "False", 09:47:30 INFO - "builduid": "5eaaa41d4d634f4fbaa5509b21b94cb8", 09:47:30 INFO - "slavebuilddir": "test" 09:47:30 INFO - } 09:47:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 09:47:30 INFO - Running post-action listener: _resource_record_post_action 09:47:30 INFO - ##### 09:47:30 INFO - ##### Running download-and-extract step. 09:47:30 INFO - ##### 09:47:30 INFO - Running pre-action listener: _resource_record_pre_action 09:47:30 INFO - Running main action method: download_and_extract 09:47:30 INFO - mkdir: /builds/slave/test/build/tests 09:47: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')]} 09:47:30 INFO - https://queue.taskcluster.net/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:47:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/test_packages.json 09:47:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/test_packages.json 09:47:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:47:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:47:32 INFO - Downloaded 1277 bytes. 09:47:32 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:47:32 INFO - Using the following test package requirements: 09:47:32 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:47:32 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:47:32 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 09:47:32 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:47:32 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 09:47:32 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:47:32 INFO - u'jsshell-mac.zip'], 09:47:32 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:47:32 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 09:47:32 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:47:32 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:47:32 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 09:47:32 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:47:32 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 09:47:32 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:47:32 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 09:47:32 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:47:32 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:47:32 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 09:47:32 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:47:32 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')]} 09:47:32 INFO - https://queue.taskcluster.net/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:47:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:47:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:47:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhOJVFk6QfOx-01v_-Xceg/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 09:47:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhOJVFk6QfOx-01v_-Xceg/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 09:47:34 INFO - Downloaded 17750655 bytes. 09:47:34 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'] 09:47:34 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 09:47:37 INFO - Return code: 0 09:47:37 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 09:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:37 INFO - https://queue.taskcluster.net/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:47:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:47:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:47:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhOJVFk6QfOx-01v_-Xceg/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 09:47:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhOJVFk6QfOx-01v_-Xceg/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 09:47:38 INFO - Downloaded 17750655 bytes. 09:47:38 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'] 09:47:38 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 09:47:42 INFO - Return code: 0 09:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:42 INFO - https://queue.taskcluster.net/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:47:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 09:47:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 09:47:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhOJVFk6QfOx-01v_-Xceg/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 09:47:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhOJVFk6QfOx-01v_-Xceg/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 09:47:43 INFO - Downloaded 10706547 bytes. 09:47:43 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'] 09:47:43 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 09:47:43 INFO - Return code: 0 09:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:43 INFO - https://queue.taskcluster.net/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:47:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:47:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:47:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 09:47:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhOJVFk6QfOx-01v_-Xceg/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 09:47:46 INFO - Downloaded 111355396 bytes. 09:47:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:47:46 INFO - mkdir: /builds/slave/test/properties 09:47:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:47:46 INFO - Writing to file /builds/slave/test/properties/build_url 09:47:46 INFO - Contents: 09:47:46 INFO - build_url:https://queue.taskcluster.net/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:47:47 INFO - Running post-action listener: _resource_record_post_action 09:47:47 INFO - Running post-action listener: set_extra_try_arguments 09:47:47 INFO - ##### 09:47:47 INFO - ##### Running populate-webroot step. 09:47:47 INFO - ##### 09:47:47 INFO - Running pre-action listener: _resource_record_pre_action 09:47:47 INFO - Running main action method: populate_webroot 09:47:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:47:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:47:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:47:47 INFO - '--tppagecycles', 09:47:47 INFO - '7'], 09:47:47 INFO - 'tests': ['tsvgm']}}, 09:47:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:47:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:47:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:47:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:47:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:47:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:47:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:47:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:47 INFO - 'talos_options': ['--e10s'], 09:47:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:47:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:47 INFO - 'tests': ['damp', 'tps']}, 09:47:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:47 INFO - 'talos_options': ['--e10s'], 09:47:47 INFO - 'tests': ['damp', 'tps']}, 09:47:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:47:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:47:47 INFO - 'other': {'tests': ['a11yr', 09:47:47 INFO - 'ts_paint', 09:47:47 INFO - 'tpaint', 09:47:47 INFO - 'sessionrestore', 09:47:47 INFO - 'sessionrestore_no_auto_restore']}, 09:47:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:47:47 INFO - 'tests': ['a11yr', 09:47:47 INFO - 'ts_paint', 09:47:47 INFO - 'tpaint', 09:47:47 INFO - 'sessionrestore', 09:47:47 INFO - 'sessionrestore_no_auto_restore']}, 09:47:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:47:47 INFO - 'tests': ['a11yr', 09:47:47 INFO - 'ts_paint', 09:47:47 INFO - 'tpaint', 09:47:47 INFO - 'sessionrestore', 09:47:47 INFO - 'sessionrestore_no_auto_restore']}, 09:47:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:47:47 INFO - 'tests': ['a11yr', 09:47:47 INFO - 'ts_paint', 09:47:47 INFO - 'tpaint', 09:47:47 INFO - 'sessionrestore', 09:47:47 INFO - 'sessionrestore_no_auto_restore']}, 09:47:47 INFO - 'other_l64': {'tests': ['a11yr', 09:47:47 INFO - 'ts_paint', 09:47:47 INFO - 'tpaint', 09:47:47 INFO - 'sessionrestore', 09:47:47 INFO - 'sessionrestore_no_auto_restore']}, 09:47:47 INFO - 'other_nol64': {'tests': ['a11yr', 09:47:47 INFO - 'ts_paint', 09:47:47 INFO - 'tpaint', 09:47:47 INFO - 'sessionrestore', 09:47:47 INFO - 'sessionrestore_no_auto_restore']}, 09:47:47 INFO - 'svgr': {'tests': ['tsvgx', 09:47:47 INFO - 'tsvgr_opacity', 09:47:47 INFO - 'tart', 09:47:47 INFO - 'tscrollx', 09:47:47 INFO - 'cart']}, 09:47:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:47:47 INFO - 'tests': ['tsvgx', 09:47:47 INFO - 'tsvgr_opacity', 09:47:47 INFO - 'tart', 09:47:47 INFO - 'tscrollx', 09:47:47 INFO - 'cart']}, 09:47:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:47 INFO - 'tests': ['tp5o']}, 09:47:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:47 INFO - 'talos_options': ['--e10s'], 09:47:47 INFO - 'tests': ['tp5o']}, 09:47:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:47 INFO - 'talos_options': ['--xperf_path', 09:47:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:47:47 INFO - 'tests': ['tp5n']}, 09:47:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:47 INFO - 'talos_options': ['--e10s', 09:47:47 INFO - '--xperf_path', 09:47:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:47:47 INFO - 'tests': ['tp5n']}}, 09:47:47 INFO - 'talos.zip': {'path': '', 09:47:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:47:47 INFO - Running post-action listener: _resource_record_post_action 09:47:47 INFO - ##### 09:47:47 INFO - ##### Running create-virtualenv step. 09:47:47 INFO - ##### 09:47:47 INFO - Running pre-action listener: _resource_record_pre_action 09:47:47 INFO - Running main action method: create_virtualenv 09:47:47 INFO - Creating virtualenv /builds/slave/test/build/venv 09:47:47 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 09:47:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:47:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:47:47 INFO - Using real prefix '/tools/python27' 09:47:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:47:48 INFO - Installing distribute.............................................................................................................................................................................................done. 09:47:51 INFO - Installing pip.................done. 09:47:51 INFO - Return code: 0 09:47:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:47: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')]} 09:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47: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')]} 09:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:51 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 0x10b4dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4e44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8af24d5550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b380d30>, '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 0x10b1a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b377b20>, '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.cYANAosIDU/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.w9mN0LCuFV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 09:47:51 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 09:47:51 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 09:47:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cYANAosIDU/Render', 09:47:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:51 INFO - 'HOME': '/Users/cltbld', 09:47:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:51 INFO - 'LOGNAME': 'cltbld', 09:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:51 INFO - 'MOZ_NO_REMOTE': '1', 09:47:51 INFO - 'NO_EM_RESTART': '1', 09:47:51 INFO - 'PAGER': '/bin/cat', 09:47:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:51 INFO - 'PWD': '/builds/slave/test', 09:47:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:51 INFO - 'SHELL': '/bin/bash', 09:47:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w9mN0LCuFV/Listeners', 09:47:51 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 09:47:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:51 INFO - 'USER': 'cltbld', 09:47:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:51 INFO - 'XPC_FLAGS': '0x0', 09:47:51 INFO - 'XPC_SERVICE_NAME': '0', 09:47:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:51 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 09:47:51 INFO - Cleaning up... 09:47:51 INFO - Return code: 0 09:47:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:47: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')]} 09:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47: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')]} 09:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:51 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 0x10b4dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4e44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8af24d5550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b380d30>, '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 0x10b1a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b377b20>, '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.cYANAosIDU/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.w9mN0LCuFV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 09:47:51 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 09:47:51 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 09:47:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cYANAosIDU/Render', 09:47:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:51 INFO - 'HOME': '/Users/cltbld', 09:47:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:51 INFO - 'LOGNAME': 'cltbld', 09:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:51 INFO - 'MOZ_NO_REMOTE': '1', 09:47:51 INFO - 'NO_EM_RESTART': '1', 09:47:51 INFO - 'PAGER': '/bin/cat', 09:47:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:51 INFO - 'PWD': '/builds/slave/test', 09:47:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:51 INFO - 'SHELL': '/bin/bash', 09:47:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w9mN0LCuFV/Listeners', 09:47:51 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 09:47:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:51 INFO - 'USER': 'cltbld', 09:47:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:51 INFO - 'XPC_FLAGS': '0x0', 09:47:51 INFO - 'XPC_SERVICE_NAME': '0', 09:47:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:52 INFO - Downloading/unpacking psutil>=0.7.1 09:47:52 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 09:47:52 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 09:47:52 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 09:47:52 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 09:47:52 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 09:47:52 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 09:47:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:47:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:47:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:47:54 INFO - Installing collected packages: psutil 09:47:54 INFO - Running setup.py install for psutil 09:47:54 INFO - building 'psutil._psutil_osx' extension 09:47:54 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 09:47:55 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 09:47:55 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 09:47:55 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 09:47:55 INFO - building 'psutil._psutil_posix' extension 09:47:55 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 09:47:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:47:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:47:55 INFO - ^ 09:47:55 INFO - 1 warning generated. 09:47:55 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 09:47:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:47:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:47:55 INFO - Successfully installed psutil 09:47:55 INFO - Cleaning up... 09:47:55 INFO - Return code: 0 09:47:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:47:55 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')]} 09:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:55 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')]} 09:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:55 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 0x10b4dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4e44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8af24d5550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b380d30>, '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 0x10b1a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b377b20>, '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.cYANAosIDU/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.w9mN0LCuFV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 09:47:55 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 09:47:55 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 09:47:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cYANAosIDU/Render', 09:47:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:55 INFO - 'HOME': '/Users/cltbld', 09:47:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:55 INFO - 'LOGNAME': 'cltbld', 09:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:55 INFO - 'MOZ_NO_REMOTE': '1', 09:47:55 INFO - 'NO_EM_RESTART': '1', 09:47:55 INFO - 'PAGER': '/bin/cat', 09:47:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:55 INFO - 'PWD': '/builds/slave/test', 09:47:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:55 INFO - 'SHELL': '/bin/bash', 09:47:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w9mN0LCuFV/Listeners', 09:47:55 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 09:47:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:55 INFO - 'USER': 'cltbld', 09:47:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:55 INFO - 'XPC_FLAGS': '0x0', 09:47:55 INFO - 'XPC_SERVICE_NAME': '0', 09:47:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:47:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:47:58 INFO - Installing collected packages: mozsystemmonitor 09:47:58 INFO - Running setup.py install for mozsystemmonitor 09:47:58 INFO - Successfully installed mozsystemmonitor 09:47:58 INFO - Cleaning up... 09:47:58 INFO - Return code: 0 09:47:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:47: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')]} 09:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47: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')]} 09:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:58 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 0x10b4dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4e44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8af24d5550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b380d30>, '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 0x10b1a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b377b20>, '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.cYANAosIDU/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.w9mN0LCuFV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 09:47:58 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 09:47:58 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 09:47:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cYANAosIDU/Render', 09:47:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:58 INFO - 'HOME': '/Users/cltbld', 09:47:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:58 INFO - 'LOGNAME': 'cltbld', 09:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:58 INFO - 'MOZ_NO_REMOTE': '1', 09:47:58 INFO - 'NO_EM_RESTART': '1', 09:47:58 INFO - 'PAGER': '/bin/cat', 09:47:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:58 INFO - 'PWD': '/builds/slave/test', 09:47:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:58 INFO - 'SHELL': '/bin/bash', 09:47:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w9mN0LCuFV/Listeners', 09:47:58 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 09:47:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:58 INFO - 'USER': 'cltbld', 09:47:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:58 INFO - 'XPC_FLAGS': '0x0', 09:47:58 INFO - 'XPC_SERVICE_NAME': '0', 09:47:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:58 INFO - Downloading/unpacking blobuploader==1.2.4 09:47:58 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 09:47:58 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 09:47:58 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 09:47:58 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 09:47:58 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 09:47:58 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 09:48:01 INFO - Downloading blobuploader-1.2.4.tar.gz 09:48:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:48:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:48:01 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 09:48:01 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 09:48:01 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 09:48:01 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 09:48:01 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 09:48:01 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 09:48:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:48:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:48:01 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 09:48:01 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 09:48:01 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 09:48:01 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 09:48:01 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 09:48:01 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 09:48:02 INFO - Downloading docopt-0.6.1.tar.gz 09:48:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:48:02 INFO - Installing collected packages: blobuploader, requests, docopt 09:48:02 INFO - Running setup.py install for blobuploader 09:48:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:48:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:48:02 INFO - Running setup.py install for requests 09:48:02 INFO - Running setup.py install for docopt 09:48:03 INFO - Successfully installed blobuploader requests docopt 09:48:03 INFO - Cleaning up... 09:48:03 INFO - Return code: 0 09:48:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:03 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')]} 09:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:03 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')]} 09:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:03 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 0x10b4dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4e44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8af24d5550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b380d30>, '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 0x10b1a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b377b20>, '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.cYANAosIDU/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.w9mN0LCuFV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 09:48:03 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 09:48:03 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 09:48:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cYANAosIDU/Render', 09:48:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:03 INFO - 'HOME': '/Users/cltbld', 09:48:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:03 INFO - 'LOGNAME': 'cltbld', 09:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:03 INFO - 'MOZ_NO_REMOTE': '1', 09:48:03 INFO - 'NO_EM_RESTART': '1', 09:48:03 INFO - 'PAGER': '/bin/cat', 09:48:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:03 INFO - 'PWD': '/builds/slave/test', 09:48:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:03 INFO - 'SHELL': '/bin/bash', 09:48:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w9mN0LCuFV/Listeners', 09:48:03 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 09:48:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:03 INFO - 'USER': 'cltbld', 09:48:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:03 INFO - 'XPC_FLAGS': '0x0', 09:48:03 INFO - 'XPC_SERVICE_NAME': '0', 09:48:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:03 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-6VScEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:03 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-4PmH2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:03 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-9zgI6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:03 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-iLoMX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:03 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-e3QcFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:04 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-TvBylt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:04 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-m2vvQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:04 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-dxoblr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:04 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-77abGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:04 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-FR5fDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:04 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Jy9wSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:04 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-fYauAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:04 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-W8tOG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:04 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-7BSQZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:04 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-MOClAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:05 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-02y02n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:05 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-57xTdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:48:05 INFO - Running setup.py install for manifestparser 09:48:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:48:05 INFO - Running setup.py install for mozcrash 09:48:05 INFO - Running setup.py install for mozdebug 09:48:05 INFO - Running setup.py install for mozdevice 09:48:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:48:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:48:05 INFO - Running setup.py install for mozfile 09:48:06 INFO - Running setup.py install for mozhttpd 09:48:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:48:06 INFO - Running setup.py install for mozinfo 09:48:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:48:06 INFO - Running setup.py install for mozInstall 09:48:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:48:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:48:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:48:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:48:06 INFO - Running setup.py install for mozleak 09:48:06 INFO - Running setup.py install for mozlog 09:48:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:48:06 INFO - Running setup.py install for moznetwork 09:48:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:48:06 INFO - Running setup.py install for mozprocess 09:48:07 INFO - Running setup.py install for mozprofile 09:48:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:48:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:48:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:48:07 INFO - Running setup.py install for mozrunner 09:48:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:48:07 INFO - Running setup.py install for mozscreenshot 09:48:07 INFO - Running setup.py install for moztest 09:48:07 INFO - Running setup.py install for mozversion 09:48:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:48:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:48:07 INFO - Cleaning up... 09:48:07 INFO - Return code: 0 09:48:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b4dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4e44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8af24d5550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b380d30>, '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 0x10b1a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b377b20>, '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.cYANAosIDU/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.w9mN0LCuFV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 09:48:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:48:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cYANAosIDU/Render', 09:48:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:07 INFO - 'HOME': '/Users/cltbld', 09:48:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:07 INFO - 'LOGNAME': 'cltbld', 09:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:07 INFO - 'MOZ_NO_REMOTE': '1', 09:48:07 INFO - 'NO_EM_RESTART': '1', 09:48:07 INFO - 'PAGER': '/bin/cat', 09:48:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:07 INFO - 'PWD': '/builds/slave/test', 09:48:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:07 INFO - 'SHELL': '/bin/bash', 09:48:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w9mN0LCuFV/Listeners', 09:48:07 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 09:48:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:07 INFO - 'USER': 'cltbld', 09:48:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:07 INFO - 'XPC_FLAGS': '0x0', 09:48:07 INFO - 'XPC_SERVICE_NAME': '0', 09:48:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:08 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-QdQ2PC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:08 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)) 09:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:08 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Hlg8aV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:08 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)) 09:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:08 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-7MLBZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:08 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)) 09:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:08 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-zNwqN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:08 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)) 09:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:08 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-_cHHkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:08 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-AqEzAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:08 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-YkUdw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:08 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-o9F_19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:08 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-hvrJhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:09 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)) 09:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:09 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-FAbtNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:09 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)) 09:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:09 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-q573Zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:09 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)) 09:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:09 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-xbxT3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:09 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)) 09:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:09 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-MG6Lrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:09 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)) 09:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:09 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-BSkHIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:09 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)) 09:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:09 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-ztyhCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:09 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Z5Rw2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:09 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Ni1d8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:48:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:12 INFO - Downloading blessings-1.6.tar.gz 09:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:48:12 INFO - Installing collected packages: blessings 09:48:12 INFO - Running setup.py install for blessings 09:48:12 INFO - Successfully installed blessings 09:48:12 INFO - Cleaning up... 09:48:12 INFO - Return code: 0 09:48:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:48:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:12 INFO - Reading from file tmpfile_stdout 09:48:12 INFO - Current package versions: 09:48:12 INFO - blessings == 1.6 09:48:12 INFO - blobuploader == 1.2.4 09:48:12 INFO - docopt == 0.6.1 09:48:12 INFO - manifestparser == 1.1 09:48:12 INFO - mozInstall == 1.12 09:48:12 INFO - mozcrash == 0.16 09:48:12 INFO - mozdebug == 0.1 09:48:12 INFO - mozdevice == 0.48 09:48:12 INFO - mozfile == 1.2 09:48:12 INFO - mozhttpd == 0.7 09:48:12 INFO - mozinfo == 0.9 09:48:12 INFO - mozleak == 0.1 09:48:12 INFO - mozlog == 3.1 09:48:12 INFO - moznetwork == 0.27 09:48:12 INFO - mozprocess == 0.22 09:48:12 INFO - mozprofile == 0.28 09:48:12 INFO - mozrunner == 6.11 09:48:12 INFO - mozscreenshot == 0.1 09:48:12 INFO - mozsystemmonitor == 0.0 09:48:12 INFO - moztest == 0.7 09:48:12 INFO - mozversion == 1.4 09:48:12 INFO - psutil == 3.1.1 09:48:12 INFO - requests == 1.2.3 09:48:12 INFO - wsgiref == 0.1.2 09:48:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48: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')]} 09:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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')]} 09:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b4dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4e44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8af24d5550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b380d30>, '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 0x10b1a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b377b20>, '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.cYANAosIDU/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.w9mN0LCuFV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 09:48:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:48:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:48:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cYANAosIDU/Render', 09:48:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:12 INFO - 'HOME': '/Users/cltbld', 09:48:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:12 INFO - 'LOGNAME': 'cltbld', 09:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:12 INFO - 'MOZ_NO_REMOTE': '1', 09:48:12 INFO - 'NO_EM_RESTART': '1', 09:48:12 INFO - 'PAGER': '/bin/cat', 09:48:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:12 INFO - 'PWD': '/builds/slave/test', 09:48:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:12 INFO - 'SHELL': '/bin/bash', 09:48:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w9mN0LCuFV/Listeners', 09:48:12 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 09:48:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:12 INFO - 'USER': 'cltbld', 09:48:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:12 INFO - 'XPC_FLAGS': '0x0', 09:48:12 INFO - 'XPC_SERVICE_NAME': '0', 09:48:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:13 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)) 09:48:13 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)) 09:48:13 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)) 09:48:13 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)) 09:48:13 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)) 09:48:13 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)) 09:48:13 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)) 09:48:13 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)) 09:48:13 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)) 09:48:13 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)) 09:48:13 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)) 09:48:13 INFO - Cleaning up... 09:48:13 INFO - Return code: 0 09:48:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:48:13 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')]} 09:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:13 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')]} 09:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:13 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 0x10b4dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4e44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8af24d5550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b380d30>, '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 0x10b1a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b377b20>, '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.cYANAosIDU/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.w9mN0LCuFV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 09:48:13 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 09:48:13 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 09:48:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cYANAosIDU/Render', 09:48:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:13 INFO - 'HOME': '/Users/cltbld', 09:48:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:13 INFO - 'LOGNAME': 'cltbld', 09:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:13 INFO - 'MOZ_NO_REMOTE': '1', 09:48:13 INFO - 'NO_EM_RESTART': '1', 09:48:13 INFO - 'PAGER': '/bin/cat', 09:48:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:13 INFO - 'PWD': '/builds/slave/test', 09:48:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:13 INFO - 'SHELL': '/bin/bash', 09:48:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w9mN0LCuFV/Listeners', 09:48:13 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 09:48:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:13 INFO - 'USER': 'cltbld', 09:48:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:13 INFO - 'XPC_FLAGS': '0x0', 09:48:13 INFO - 'XPC_SERVICE_NAME': '0', 09:48:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:13 INFO - Downloading/unpacking jsonschema 09:48:13 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 09:48:13 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 09:48:13 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 09:48:13 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 09:48:13 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 09:48:13 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 09:48:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:48:15 INFO - Downloading/unpacking functools32 (from jsonschema) 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:15 INFO - Downloading functools32-3.2.3-2.tar.gz 09:48:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:48:16 INFO - warning: no files found matching '*.txt' 09:48:16 INFO - no previously-included directories found matching 'build' 09:48:16 INFO - no previously-included directories found matching 'dist' 09:48:16 INFO - no previously-included directories found matching '.git*' 09:48:16 INFO - Installing collected packages: jsonschema, functools32 09:48:16 INFO - Running setup.py install for functools32 09:48:16 INFO - warning: no files found matching '*.txt' 09:48:16 INFO - no previously-included directories found matching 'build' 09:48:16 INFO - no previously-included directories found matching 'dist' 09:48:16 INFO - no previously-included directories found matching '.git*' 09:48:16 INFO - Successfully installed jsonschema functools32 09:48:16 INFO - Cleaning up... 09:48:16 INFO - Return code: 0 09:48:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:48:16 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')]} 09:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:16 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')]} 09:48:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:16 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 0x10b4dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4e44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8af24d5550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b380d30>, '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 0x10b1a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b377b20>, '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.cYANAosIDU/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.w9mN0LCuFV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 09:48:16 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 09:48:16 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 09:48:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cYANAosIDU/Render', 09:48:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:16 INFO - 'HOME': '/Users/cltbld', 09:48:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:16 INFO - 'LOGNAME': 'cltbld', 09:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:16 INFO - 'MOZ_NO_REMOTE': '1', 09:48:16 INFO - 'NO_EM_RESTART': '1', 09:48:16 INFO - 'PAGER': '/bin/cat', 09:48:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:16 INFO - 'PWD': '/builds/slave/test', 09:48:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:16 INFO - 'SHELL': '/bin/bash', 09:48:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w9mN0LCuFV/Listeners', 09:48:16 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 09:48:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:16 INFO - 'USER': 'cltbld', 09:48:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:16 INFO - 'XPC_FLAGS': '0x0', 09:48:16 INFO - 'XPC_SERVICE_NAME': '0', 09:48:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:16 INFO - Downloading/unpacking flake8 09:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:48:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:48:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:48:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:48:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:48:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:48:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:48:20 INFO - no previously-included directories found matching 'docs/_build' 09:48:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:48:20 INFO - Running setup.py install for pep8 09:48:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:48:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:48:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:48:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:48:20 INFO - no previously-included directories found matching 'docs/_build' 09:48:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:48:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:48:20 INFO - Cleaning up... 09:48:20 INFO - Return code: 0 09:48:20 INFO - Running post-action listener: _resource_record_post_action 09:48:20 INFO - Running post-action listener: _start_resource_monitoring 09:48:20 INFO - Starting resource monitoring. 09:48:20 INFO - ##### 09:48:20 INFO - ##### Running install step. 09:48:20 INFO - ##### 09:48:20 INFO - Running pre-action listener: _resource_record_pre_action 09:48:20 INFO - Running main action method: install 09:48:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:20 INFO - Reading from file tmpfile_stdout 09:48:20 INFO - Detecting whether we're running mozinstall >=1.0... 09:48:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:48:20 INFO - Reading from file tmpfile_stdout 09:48:20 INFO - Output received: 09:48:20 INFO - Usage: mozinstall [options] installer 09:48:20 INFO - Options: 09:48:20 INFO - -h, --help show this help message and exit 09:48:20 INFO - -d DEST, --destination=DEST 09:48:20 INFO - Directory to install application into. [default: 09:48:20 INFO - "/builds/slave/test"] 09:48:20 INFO - --app=APP Application being installed. [default: firefox] 09:48:20 INFO - mkdir: /builds/slave/test/build/application 09:48:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:48:55 INFO - Reading from file tmpfile_stdout 09:48:55 INFO - Output received: 09:48:55 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 09:48:55 INFO - Running post-action listener: _resource_record_post_action 09:48:55 INFO - ##### 09:48:55 INFO - ##### Running run-tests step. 09:48:55 INFO - ##### 09:48:55 INFO - Running pre-action listener: _resource_record_pre_action 09:48:55 INFO - Running main action method: run_tests 09:48:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:48:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:48:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:48:55 INFO - 2016-02-10 09:48:55.115 screenresolution[1929:9253] starting screenresolution argv=screenresolution get 09:48:55 INFO - 2016-02-10 09:48:55.118 screenresolution[1929:9253] Display 0: 1600x1200x32@60 09:48:55 INFO - 2016-02-10 09:48:55.124 screenresolution[1930:9255] starting screenresolution argv=screenresolution list 09:48:55 INFO - Available Modes on Display 0 09:48:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:48:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:48:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:48:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:48:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:48:55 INFO - Intel Iris: 09:48:55 INFO - Chipset Model: Intel Iris 09:48:55 INFO - Type: GPU 09:48:55 INFO - Bus: Built-In 09:48:55 INFO - VRAM (Dynamic, Max): 1536 MB 09:48:55 INFO - Vendor: Intel (0x8086) 09:48:55 INFO - Device ID: 0x0a2e 09:48:55 INFO - Revision ID: 0x0009 09:48:55 INFO - Displays: 09:48:55 INFO - Display: 09:48:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:48:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:48:55 INFO - Display Serial Number: 1600x1200 60 09:48:55 INFO - Main Display: Yes 09:48:55 INFO - Mirror: Off 09:48:55 INFO - Online: Yes 09:48:55 INFO - Rotation: Supported 09:48:55 INFO - Return code: 0 09:48:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:48:55 INFO - Python 2.7.3 09:48:55 INFO - Return code: 0 09:48:55 INFO - grabbing minidump binary from tooltool 09:48:55 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')]} 09:48:55 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 0x10b380d30>, '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 0x10b1a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b377b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:48:55 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 09:48:55 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 09:48:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:48:55 INFO - Return code: 0 09:48:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:48:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:48:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:48:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:48:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:48:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:48:56 INFO - Return code: 0 09:48:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--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 09:48:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0051 --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 09:48:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cYANAosIDU/Render', 09:48:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:56 INFO - 'HOME': '/Users/cltbld', 09:48:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:56 INFO - 'LOGNAME': 'cltbld', 09:48:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:48:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:56 INFO - 'MOZ_NO_REMOTE': '1', 09:48:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:48:56 INFO - 'NO_EM_RESTART': '1', 09:48:56 INFO - 'PAGER': '/bin/cat', 09:48:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:56 INFO - 'PWD': '/builds/slave/test', 09:48:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:48:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:56 INFO - 'SHELL': '/bin/bash', 09:48:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w9mN0LCuFV/Listeners', 09:48:56 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 09:48:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:56 INFO - 'USER': 'cltbld', 09:48:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:56 INFO - 'XPC_FLAGS': '0x0', 09:48:56 INFO - 'XPC_SERVICE_NAME': '0', 09:48:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--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 09:48:56 INFO - mozversion application_buildid: 20160210071115 09:48:56 INFO - mozversion application_changeset: ac39fba33c6daf95b2cda71e588ca18e2eb752ab 09:48:56 INFO - mozversion application_display_name: Nightly 09:48:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:48:56 INFO - mozversion application_name: Firefox 09:48:56 INFO - mozversion application_remotingname: firefox 09:48:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:48:56 INFO - mozversion application_vendor: Mozilla 09:48:56 INFO - mozversion application_version: 47.0a1 09:48:56 INFO - mozversion platform_buildid: 20160210071115 09:48:56 INFO - mozversion platform_changeset: ac39fba33c6daf95b2cda71e588ca18e2eb752ab 09:48:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:48:56 INFO - mozversion platform_version: 47.0a1 09:48:56 INFO - using testdate: 1455126536 09:48:56 INFO - actual date: 1455126536 09:48:57 INFO - starting webserver on 'localhost:49450' 09:48:57 INFO - SUITE-START | Running 2 tests 09:48:57 INFO - TEST-START | dromaeo_css 09:48:57 INFO - operating with platform_type : mac_ 09:48:57 INFO - Initialising browser for dromaeo_css test... 09:48:57 INFO - TEST-INFO | started process 1948 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpvE9Sv6/profile http://localhost:49450/getInfo.html) 09:48:59 INFO - PROCESS | 1948 | __metrics Screen width/height:1600/1200 09:48:59 INFO - PROCESS | 1948 | colorDepth:24 09:48:59 INFO - PROCESS | 1948 | Browser inner width/height: 1024/689 09:48:59 INFO - PROCESS | 1948 | __metrics 09:48:59 INFO - PROCESS | 1948 | 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" 09:48:59 INFO - PROCESS | 1948 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:49:00 INFO - TEST-INFO | 1948: exit 0 09:49:00 INFO - Browser initialized. 09:49:00 INFO - Running cycle 1/1 for dromaeo_css test... 09:49:00 INFO - TEST-INFO | started process 1952 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpvE9Sv6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:12 INFO - PROCESS | 1952 | RSS: Main: 247115776 09:49:12 INFO - PROCESS | 1952 | 09:50:04 INFO - PROCESS | 1952 | 1455126604450 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] 09:52:13 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49450/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49450/tests/dromaeo/cssquery-ext.html) 09:52:15 INFO - PROCESS | 1952 | RSS: Main: 401457152 09:52:15 INFO - PROCESS | 1952 | 09:55:18 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49450/tests/dromaeo/cssquery-ext.html (next: http://localhost:49450/tests/dromaeo/cssquery-jquery.html) 09:55:19 INFO - PROCESS | 1952 | RSS: Main: 384409600 09:55:19 INFO - PROCESS | 1952 | 09:58:21 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49450/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49450/tests/dromaeo/cssquery-mootools.html) 09:58:21 INFO - PROCESS | 1952 | RSS: Main: 379301888 09:58:21 INFO - PROCESS | 1952 | 10:01:24 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49450/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49450/tests/dromaeo/cssquery-prototype.html) 10:01:24 INFO - PROCESS | 1952 | RSS: Main: 335216640 10:01:24 INFO - PROCESS | 1952 | 10:04:28 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49450/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49450/tests/dromaeo/cssquery-yui.html) 10:04:28 INFO - PROCESS | 1952 | RSS: Main: 346800128 10:04:28 INFO - PROCESS | 1952 | 10:07:31 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49450/tests/dromaeo/cssquery-yui.html (next: http://localhost:49450/tests/dromaeo/cssquery-dojo.html) 10:07:31 INFO - PROCESS | 1952 | RSS: Main: 390582272 10:07:31 INFO - PROCESS | 1952 | 10:07:31 INFO - PROCESS | 1952 | __start_tp_report 10:07:31 INFO - PROCESS | 1952 | _x_x_mozilla_page_load 10:07:31 INFO - PROCESS | 1952 | _x_x_mozilla_page_load_details 10:07:31 INFO - PROCESS | 1952 | |i|pagename|runs| 10:07:31 INFO - PROCESS | 1952 | |0;dojo.html;3207.7433805295577;3510.192655689192;3517.402041652919;3518.190816112294;3576.2668652926154;5616.775328986836;5708.800191993281;5747.655140691556;5760.193572899792;5765.3369862465825;5725.227094342263;5752.626079304852;5852.326982397026;5872.500837428824;5903.055511118222;5096.949030509703;5131.102057140004;5151.639385243035;5164.4060932992625;5284.075286824809;5275.208718692208;5305.840824775243;5316;5323.281357016792;5359.866003349908;5132.692038477685;5204.323437953042;5215.1134307167495;5226.555742761831;5273.815416460425;5135.74321283938;5217.686938783647;5225.425203227642;5251.028559716465;5306.071437498423;4285.550017248175;5218.373795144607;5218.930119325529;5241.8165364212455;5247.763850626731;5631.2960879890015;5710.114932185518;5719.113537401709;5727.341355744101;5750.770148067202;6158.815235542941;6196.411340922605;6277.87444251117;6303;6310.211223597051;5451.945480545223;6308.779192728232;6312.116303717483;6314.589551679126;6336.46140078094;5270.130428479335;5763.769449221984;5814.069748840166;5846.824595262149;5854.034084376115;6234.220722409699;6237.313895471494;6313.3686631336495;6324.620522768557;6338.873222535616;6204.410580994799;6207.34822843604;6217.533684973645;6241.313455519889;6253.530985176039;6172.105044768484;6293.748250070037;6295.905561416583;6306.842328941813;6325.9051114233325;6174.166487524217;6227.377262273827;6295.811125666238;6312.715927783261;6316.747330106836;6286.088517165077;6292.622442653455;6313.842153946188;6317.684115794192;6320.936790632127;4869.318295438641;4906.386701662293;4944.3572335596145;4964.975175124174;5004.099262132779;4462.933056004163;4488.192125417391;4502.617277531381;4503.932441013388;4527.501974782771;5714.571407144481;5732.3121225453215;5733.369329373765;5736.913946290809;5739.196512488255;6203.7828675996125;6265.8746825063245;6272.18461599989;6275.215598050244;6309.211348581427;5711.286089238845;5760.596758226968;5768.596198266165;5776.566757493205;5800.622959507703;5295.920561191585;5417.18742188667;5421.430749771296;5434.266374039454;5435.211894275387;6324.462420694293;6328.240611126602;6401.935980640134;6415.486761059104;6423.646699431482;6272.40412160844;6295.96852015737;6310.368963103837;6320.5891617044745;6325.1144839721555;6241.3134555197985;6314.810555683153;6390.872182556416;6403.2316122063785;6415;5772.538196944319;5806.618253345299;6176.258848938156;6281.497480201664;6310.463610593151;5785.363610002981;5852.712403271274;6286.088517165077;6297.307296197323;6335.1130841683125;6055.2733671957885;6111.470193407107;6118.724657390517;6159.538034647509;6190.969045154746;6025.6083354581815;6097.664628445478;6104.969475152596;6111.602745821508;6126;5877.441643043904;5932.436418540232;5934.465898069195;5939.109133629817;5953.613015154175;6059.242594675666;6111.419415155553;6121.785737499166;6169.629822210682;6175.96912015437;6058.242719660043;6061.030235162353;6077.787277445268;6107.84730381744;6107.877842443215 10:07:31 INFO - PROCESS | 1952 | |1;ext.html;438.8573713543099;451.1608408360451;472.2727000419354;535.5715427657873;586.6509426891;29118.854405727994;36798.44802327964;37837.43243851337;37946.81026594863;38019.429708554395;40208.59791402085;40512.392314115314;40700.59299407005;40796.38805417921;40852.18295634093;9523.761905952355;9722.90277097227;9726.756831079245;9749.122578967892;9753.463559504224;9452.95273523635;9582;9583.424994500352;9591.232701383873;9597.904020959772;9547.522623868814;9629.951850240739;9630.759231019245;9634.47010414427;9642.951785241099;9545.284103692216;9604.279679024101;9611.519424028771;9616.615335386576;9640.758981025496;9445.858312125323;9563.378380405251;9572.282078844115;9577.569009394594;9580.712578622582;34129.317413651836;36585.81707091474;38397;38834.02914927121;38850.61149388498;3096.5664806927048;3160.083575763026;3160.1783536280504;3199.104250809777;3376.797392156454;27997.300067498272;28287;28683;28805.99179028724;29520.70479295201;2719.714429984863;2723.945521089567;2736.822106563067;2872.2819295176205;2944.440556294297;403752;404721;405032;405224;405937.97031014954;53345;54657.45342546603;56750.7162464185;61069.69465152646;65782;50669.49330506721;62645;62985.68507157435;63021.05468417978;63141.68429157825;15479.5356139316;15700.371985120468;15714;15741.055536667836;15743.527694169194;9750;10973.177011724152;11137.721556961142;12103.697407564705;12175.939120304341;20014.799852001586;20281.898590506953;20300.695489567668;20327.695084573745;20329.593408132052;8838.469691818511;8874.968928660204;9116.498592577473;9128.26973842091;9207.217386522221;963.9277054220961;999.2106236073566;999.3604093380243;1052.3685788526975;1084.2681190196586;28440.573391399146;28808.855955720086;29239.01585217869;29649.110526684235;29692.257693557403;1038.039813172812;1049.3913530152493;1065.5471424644495;1083.8482612434266;1087.907527860125;13452.730945381234;14057.297135143202;14164.008519403544;14403.351849166604;14440.638984025274;635244;652449;653054;653200;653815;55093.347199584074;55470.72264638651;55502;55639.60900977427;55828.72085639627;1408.9929550352388;1420.240171508238;1434.7202295552477;1439.8920080993757;1439.964000899944;27723.40287902206;28080.29799255035;28086.43827123487;28099.859500702365;28102.43795124127;46114;46671;46692.7665361671;46709.29936050894;46820;492211;509735;524126.379368116;529944;533615;31075.980061296847;31202.843985779928;31307.84346078255;31385.215369615944;31502.684973150892;40001.59998399979;40355.79822100871;40574.79712601418;41003.76988690344;41541;34173.82913085419;35025.64974350224;35275.64724352724;35277.64722352846;39795;37152.81423592865;37294.62705372911;37605.24789504249;38013;38118.61881381151;37681.43477847889;38085.80957095197;38128.23743525169;38211.61788382192;39269.803650981565;33826.49260261147;36428.81785591055;37573.62426375701;37823.05442363963;38164;24978.500429990934;25946.481070378864;26031.349216269744;26038.218853434428;26771.598426023236 10:07:31 INFO - PROCESS | 1952 | |2;jquery.html;309.7166093024882;318.5190362552545;358.8564574170333;360.868283076677;371.1945079178183;13223.867761322384;15431.69136617267;15717.20800279397;19126.808731912675;20550.89724551377;11693.649190524298;12103.21329113607;15496.380144794222;20012.999350032514;20013.499662508446;5177.990291893073;5368.409474957752;5372.435894231108;5372.489613486712;5378.327709036371;3913.1977944521445;4097.877063688079;5368.275282836806;5416.268803711508;5417.864553386157;4106.096658735073;4109.4041364002205;4110.97944510277;4111.506619205699;7277.672504737299;7200.171980222263;7487.588182649952;7502.287282708134;7506.399488040998;7511.399088072995;6946.6179360135175;7097.964510177416;7128.6435678215885;7163.1762347330205;7165.6417179140835;25551.85016674254;26522.86738566314;26561.867190664118;26908.73091269082;26932.59601105985;2172.2397160993683;2435.1233555919853;2621.829581077243;2821.6614006319373;2827.2790438438274;15246.847531524654;15867.841321586751;16059.598510037225;16185.757213641804;16408.589785255463;1852.3609354772582;1902.296150424338;1915.1190452391777;1932.468571142933;1957.2660252405349;73198;80632;103484.48257758738;104247.43628845573;108003;15625.218739063;18007.72988405175;18479.722804157947;18903;19072.71390929137;27788.58317125245;28077;28160.29599259994;28161.295967600974;28192.718072819418;10352;10355.43045132525;10434.321769084985;10445.895541044492;10523.368597884151;8797.38418310725;8840.734777956672;8843.0714774949;8924.375293729376;8932.553372331358;7428.034355533746;8623.353248506388;8646.956765216133;8735.213830755136;8822.985356683936;1861.6835138026568;1883.2278765705994;1905.199356945316;2237.351168161215;3238.2875767331147;840.7015509494164;918.3755046568264;923.9630414783468;957.4686049242737;976.4043933200742;16441;19206.519837004187;20350.796492035188;20615.45384096199;20865.269715559883;886.7605746448423;893.7631527645179;908.0601577367393;951.6003278622995;988.9950550247203;10046;10943.28868623537;10945.671629851116;11051.226414150933;11081.667549973514;694627;698654.5067274631;730566;759561;760067.3959562444;86140;114122;114363;117065.71928986491;117483;1099.3074363151163;1142.9828552571719;1156.6587856582328;1158.4902642837126;1159.2580748320913;18385.90807045956;18704.345347912757;18752.62494750125;18793.590480714276;18848.52878678044;46675.83310417267;47393.28910066283;47555;49015.75492122517;50013;67887.32112679008;68222.3177768216;69121.65439172772;69418.65290673514;69869;7212.3148300911325;7540.265738880198;7629.16079231273;7632.89323048166;7710.7686769397005;7950.960245198969;9378.906210937803;11713.531458741554;11827.586034489095;12059.57791477294;9294.395864268801;10365.360071115325;10529.894701053197;10531.947340263556;10799.082078023455;10393.740156496147;10530.42082685429;10548.947255263674;10759.085477734166;10867.891321087005;10218.029287217703;10454.477276136315;10602;10802;10936;7484.064491938508;7638.732644357421;7640.503367281109;7686.154523002577;7711.228877112244;10080.798384032425;10696.465176741287;10863.130949524177;10872.565097396331;10975.341479511255 10:07:31 INFO - PROCESS | 1952 | |3;mootools.html;1386.5978866128823;1510.7582786754117;1530.4337395163784;1770.8937463752177;1943.0673276827122;7869.960650196748;8512.872306915393;8647.69733059343;8650.43772154811;8661.610227539752;8273.04859941107;8501.872471912926;8561.315094792417;8563.229309362156;8564.357673174522;2183.094015983365;2226.908814680811;2439.3657649011207;2480.776730094291;2515.5094756522485;2471.221565206963;2500.7874330681916;2504.9749502504924;2505.498900219954;2506.320765087387;2460.2619214235747;2498.1381423408893;2502.2618327593405;2506.887190076442;2513.622956556522;2415.867127307997;2479.7396273391214;2479.9132030379033;2481.4416756229884;2488.0172331928966;2068.7414073240843;2395.7604239575903;2430.927072187837;2450.8774561271866;2451.889664965081;8716.302695784321;8795.60419781105;8796.956015219946;8805.735827925173;8830.381873268874;5412.242286079952;5566.721663916788;5572.637778544382;5577.2191893135;5578.386377498472;3668.761530500509;3707.017640325316;3776.4901738265257;3778.471014058034;3787.4697542344093;1042.0933787604831;1048.09863517375;1062.3944351719524;1093.8632670916136;1112.0825319111684;11896.345700986441;11898.22661526998;11906.404679765978;11916.880831191751;11933.224340417844;4925.532074452921;4947.60419166473;5020.221865610836;5067.315912351859;5072.264521644341;10310.07209351147;10319.071283584513;10333.48332583383;10334.534945927451;10340.948295258626;5561.971035358471;5568;5568.888622227532;5572.0527510323345;5575.776968921279;4896.853094407174;5044.747762611854;5048.949510504848;5052.646314758005;5053.140966035783;3711.0536813112485;3788.431735239736;3788.5453745550712;3803;3803.2583646188727;1298.1497119386818;1331.863416959656;1339.8057281694294;1344.3815844711346;1352.1886867879193;1092.5192915117323;1104.0505165557613;1111.105560024172;1242.937853107341;1350.7433587618518;6877.415419689282;8026.478278911852;8187.0994190638985;8191.303739182236;8209.753707388787;1168.8013037783596;1169.7309618787726;1174.6065068202247;1187.2935603316187;1195.3186683590443;6203.875922481525;6226.066090086523;6298.338674439118;6302.432781049728;6315.273743519462;10488.947555262328;10738.140948724084;10878.96649818266;10886.23796334249;10894.782104357868;10458.320209186379;10611.84082238767;10624.681259562225;10732.73168170802;10739.033486986209;6679.86640267192;8228.25945664893;8306.750797476085;8310.21052999964;8311.99999999988;7797.571133587707;7820.983272174809;7868;7889.211078892295;7899.84200315979;9517.904820951702;9613.51932403363;9633.470159141314;9645.37305075168;9747.220222382051;9715.708528743866;9886.159676427584;9968.252381071303;10032.69901902944;10153.289269751047;7145.606991615511;7504.399648028036;7528.924710752823;7594.468387212842;7594.734184303523;7463.402927765657;7641.121271053677;8180.550069746221;8289.171082891662;8378;7589.848203036019;7590.203028681909;7644.120926093348;7795.493292935941;7803.648835802516;7457.850842983002;7506.624668766431;7581.128170260491;7626.275503827128;7639.923600764144;7557.093148822177;7645.273698998586;7654.119776225805;7692.000039994765;7703.152653208031;6968.721251149897;7010.263922288086;7013.4038606719005;7015.052967849275;7021.859562808613;6883.655817209019;7022.052022977037;7039.120109986252;7073.787786366417;7079.646017699198 10:07:31 INFO - PROCESS | 1952 | |4;prototype.html;320.4200397280921;324.5650827890626;329.5748484455052;333.30339590256347;337.36070147071314;6662.100616416782;6696.7990960271145;6705.631190284533;6742.629155396451;6760.763373281936;6651.068850360941;6726.764563240287;6730.158730158731;6740.66296685165;6761.256261811209;4938.975305123478;4940.851774446773;4945.431275403339;4947.604191664676;4961.8015279388965;4182.707210495267;4832.178529649968;4840.661153719241;4845.636577256702;4848.7090774553635;4793.2810078488155;4805.495422980589;4818.879528011793;4837.782299796518;4840.6369522285795;4627.768611569408;4735.337052812609;4744.620430365562;4839.128956787777;4865.781039853197;3293.818839963801;4032.3145065338963;4036.1524079942956;4037.7173597848164;4038.7980600970127;6190.442860142563;6510.251321098087;6511.088447617338;6518.739250429977;6524.11924390206;5637.3235211774845;5645.266115404971;5652.123920792284;5655.632383895075;5666.46168613981;6124.7138100998845;6451.161349024644;7147.785566433015;7155.856882862314;7162.319579639926;4665.227213658822;4761.095391875532;4767.332573439721;4776.498467660915;4790.089882922233;7324.48728588999;7532.661030253597;7556.866470029485;7563.168051514329;7563.924360756432;4864;4868.415790105139;4876.8780780480065;4877.268409738496;4885.8289959851945;4933.555979961749;4944.703317800943;4945.258211268267;4954.3063971044085;4963.70217786934;5587.273654424899;5684.54523638108;5693.28833895763;5698.1737648041635;5900.704964751745;6970.407515361149;7093.255208203168;7115.075040244838;7239.719488361149;7260.491765576359;1670.9331626734795;1702.6169111949712;1716.3220527891663;1716.6995775739445;1717.6908156531695;1087.1140020882956;1102.6691992402407;1117.932924024561;1124.0726400719439;1135.9772804543863;6033.245844269466;6550.069958025147;6569.408753212234;6594.670266486656;6594.9670251649395;5992;7411.62941852916;7415.5179913305465;7418.591977441292;7424.034875466263;6339.841503962438;6571.2771595124495;6590.637514936724;6591.934080659132;6612.140421745143;3913.5695073541888;3935.0752573145287;3942.0933185367526;3942.290387730236;3950.249452603996;7636.809079772939;7668.424868134801;7685.03937007874;7704.8459030820195;7705.267999540147;7280.745173918887;7615.923840761521;7623.847523049508;7624.08510978675;7637.5035622684345;7654.502457340255;7663.31030207284;7672.117706463828;7674.961625192062;7683.1548529661695;6569.948808190667;6852.246252912076;7380.520266182681;7385.187629360874;7387.519811212254;5794.725160464691;7174.246704095995;7254.657888290683;7256.7460138894885;7276.7089316426745;7643.541387516767;7646.541207527566;7652.7704168875025;7667;7677.808054798675;4891.828785992473;4898.265260210855;4901.387326584177;4910.21436570147;4913.975430122827;7037.964810175917;7094.290570942864;7258.89111663336;7340.082489688789;7349.742759003623;6982.7206911725;7026.789196324118;7030.261822508563;7237.63811809418;7247.456440766858;5911.793087241926;7218.819529511804;7251.456140789356;7254.492185546961;7263.455240856852;6817.8636427270185;7043.330883566053;7046.859062818818;7048.718051277891;7073.045138906387;7240.275972402717;7252.782416527512;7270.655498470763;7273.8908916365235;7274.599897005715;6868.862622747617;7102.893456598052;7113.466490013373;7114.14630244374;7116.715331386687 10:07:31 INFO - PROCESS | 1952 | |5;yui.html;652.5301782716444;657.1489920552884;683.8187880211742;718.8418547919456;783.2637320918336;14490.5652830415;14697;14702.999999999987;14707.485238016672;14717.411303547871;13249.337533123353;13327.26700031498;13340.266285354302;13384.732305353911;13398.717314257996;835.5237514616671;850.8553545897213;851.4210336970857;852.109545524928;854.0434713121313;695.1415002471944;702.6276073680932;847.8812966184709;849.8470275350435;851.0510780479782;876.2114097312406;885.2431171348501;886.7738726624701;887.3078998381241;912.5482885971453;714.8927660850862;725.2674798453547;884.0275696733606;888.2449917570078;906.7959709065474;654.0026459649026;655.9606423614598;656.4092316914815;656.5961933410965;662.0169048962288;14512.1292722437;14563.344649490798;14565.781513277203;14580.70838583233;14591.70816583673;12499.750004999849;12652.177608455513;12733.808992865115;12799.680007999781;12804.61586152417;10024.94987525065;10026.574303544205;10133;10175.796484070277;10203.183745300357;2975.538791487323;3473.6005359383744;3673.430618254175;3698.0754811297174;3711.554613446404;83382.58308708479;84966.57516712439;88087.55956220177;88239;88608.99999999936;9610.279229057849;9671.419714817133;9734.451502248761;9737.756556086155;9746.171575416169;21608.675869861963;21738.565228695337;21756.34730958074;21763.347099587038;21780.455488612595;7538.585377804164;7542.6605802739;7609.391248700091;7615.16233214346;7703.075630924212;4137.91724165521;4138.172365526907;4147.31386424797;4190.434291370687;4217.030083080908;3482.1120614243205;3509.473578963125;3510.929781404409;3517.736169787276;3522.6125126236093;616.4544378225303;628.1112226199967;629.7481007596998;637.2766909557686;638.1735652330243;573.2977103048732;594.8750762339957;614.5851550203595;616.9321374648785;628.8144997225829;8348.916510834813;9091.908970923532;9229.123233292827;9455.443326579643;9476.810463790685;494.50302446041496;585.2479563760547;598.9251343582052;599.7121381736704;609.2158834128081;3646.3254297954963;3714.9628503715157;3752.962470375316;3973.7417067890497;4052.0882801370044;86190.56904715436;87183.1281687175;87497;87575.56212219025;87787;68763.65618171878;68895.65552172207;69891.3010869895;70016;70925.64537177281;57129;57626.55933601609;62541;62746;65299.10772274378;7689.615519224129;8851.40674678564;9038.774030649287;9102.863457048283;9314.068593140631;50321.245181321574;53266.66833329198;53962.46037539574;56862.14706779319;57616.71191644015;68898;70571;70577.64711176412;72213.91679124712;73621;11258.38078905668;11519.07847372225;11634.64698676379;11637.476313565741;12336.753264934472;11997.220180688577;12008.63974080779;12018;12035.338056406981;12041.397930103634;11424.257423267461;11432.48553815097;11434.142439316918;11444;11488.138389620979;11490.88509114898;11492.080633549464;11495.31028138281;11495.770084598094;11537.423128843691;11306.717332066435;11318.943405283251;11320.886791131983;11324;11329.263597866113;8077.353811695168;9236.72289831306;9575.329726919048;9847.113759761656;9848.852267216142;9900.702978910644;9915.900840991786;9938.900610993798;9948.950255248677;9966.451845148586 10:07:31 INFO - PROCESS | 1952 | __end_tp_report 10:07:31 INFO - PROCESS | 1952 | __start_cc_report 10:07:31 INFO - PROCESS | 1952 | _x_x_mozilla_cycle_collect,1899 10:07:31 INFO - PROCESS | 1952 | __end_cc_report 10:07:31 INFO - PROCESS | 1952 | __startTimestamp1455127651840__endTimestamp 10:07:31 INFO - PROCESS | 1952 | 10:07:31 INFO - PROCESS | 1952 | ------- Summary: start ------- 10:07:31 INFO - PROCESS | 1952 | Number of tests: 6 10:07:31 INFO - PROCESS | 1952 | 10:07:31 INFO - PROCESS | 1952 | [#0] dojo.html Cycles:165 Average:5767.16 Median:5934.47 stddev:642.59 (10.8%) stddev-sans-first:612.39 10:07:31 INFO - PROCESS | 1952 | Values: 3207.7 3510.2 3517.4 3518.2 3576.3 5616.8 5708.8 5747.7 5760.2 5765.3 5725.2 5752.6 5852.3 5872.5 5903.1 5096.9 5131.1 5151.6 5164.4 5284.1 5275.2 5305.8 5316.0 5323.3 5359.9 5132.7 5204.3 5215.1 5226.6 5273.8 5135.7 5217.7 5225.4 5251.0 5306.1 4285.6 5218.4 5218.9 5241.8 5247.8 5631.3 5710.1 5719.1 5727.3 5750.8 6158.8 6196.4 6277.9 6303.0 6310.2 5451.9 6308.8 6312.1 6314.6 6336.5 5270.1 5763.8 5814.1 5846.8 5854.0 6234.2 6237.3 6313.4 6324.6 6338.9 6204.4 6207.3 6217.5 6241.3 6253.5 6172.1 6293.7 6295.9 6306.8 6325.9 6174.2 6227.4 6295.8 6312.7 6316.7 6286.1 6292.6 6313.8 6317.7 6320.9 4869.3 4906.4 4944.4 4965.0 5004.1 4462.9 4488.2 4502.6 4503.9 4527.5 5714.6 5732.3 5733.4 5736.9 5739.2 6203.8 6265.9 6272.2 6275.2 6309.2 5711.3 5760.6 5768.6 5776.6 5800.6 5295.9 5417.2 5421.4 5434.3 5435.2 6324.5 6328.2 6401.9 6415.5 6423.6 6272.4 6296.0 6310.4 6320.6 6325.1 6241.3 6314.8 6390.9 6403.2 6415.0 5772.5 5806.6 6176.3 6281.5 6310.5 5785.4 5852.7 6286.1 6297.3 6335.1 6055.3 6111.5 6118.7 6159.5 6191.0 6025.6 6097.7 6105.0 6111.6 6126.0 5877.4 5932.4 5934.5 5939.1 5953.6 6059.2 6111.4 6121.8 6169.6 6176.0 6058.2 6061.0 6077.8 6107.8 6107.9 10:07:31 INFO - PROCESS | 1952 | 10:07:31 INFO - PROCESS | 1952 | [#1] ext.html Cycles:180 Average:65776.35 Median:38304.31 stddev:142623.08 (372.3%) stddev-sans-first:142938.81 10:07:31 INFO - PROCESS | 1952 | Values: 438.9 451.2 472.3 535.6 586.7 29118.9 36798.4 37837.4 37946.8 38019.4 40208.6 40512.4 40700.6 40796.4 40852.2 9523.8 9722.9 9726.8 9749.1 9753.5 9453.0 9582.0 9583.4 9591.2 9597.9 9547.5 9630.0 9630.8 9634.5 9643.0 9545.3 9604.3 9611.5 9616.6 9640.8 9445.9 9563.4 9572.3 9577.6 9580.7 34129.3 36585.8 38397.0 38834.0 38850.6 3096.6 3160.1 3160.2 3199.1 3376.8 27997.3 28287.0 28683.0 28806.0 29520.7 2719.7 2723.9 2736.8 2872.3 2944.4 403752.0 404721.0 405032.0 405224.0 405938.0 53345.0 54657.5 56750.7 61069.7 65782.0 50669.5 62645.0 62985.7 63021.1 63141.7 15479.5 15700.4 15714.0 15741.1 15743.5 9750.0 10973.2 11137.7 12103.7 12175.9 20014.8 20281.9 20300.7 20327.7 20329.6 8838.5 8875.0 9116.5 9128.3 9207.2 963.9 999.2 999.4 1052.4 1084.3 28440.6 28808.9 29239.0 29649.1 29692.3 1038.0 1049.4 1065.5 1083.8 1087.9 13452.7 14057.3 14164.0 14403.4 14440.6 635244.0 652449.0 653054.0 653200.0 653815.0 55093.3 55470.7 55502.0 55639.6 55828.7 1409.0 1420.2 1434.7 1439.9 1440.0 27723.4 28080.3 28086.4 28099.9 28102.4 46114.0 46671.0 46692.8 46709.3 46820.0 492211.0 509735.0 524126.4 529944.0 533615.0 31076.0 31202.8 31307.8 31385.2 31502.7 40001.6 40355.8 40574.8 41003.8 41541.0 34173.8 35025.6 35275.6 35277.6 39795.0 37152.8 37294.6 37605.2 38013.0 38118.6 37681.4 38085.8 38128.2 38211.6 39269.8 33826.5 36428.8 37573.6 37823.1 38164.0 24978.5 25946.5 26031.3 26038.2 26771.6 10:07:31 INFO - PROCESS | 1952 | 10:07:31 INFO - PROCESS | 1952 | [#2] jquery.html Cycles:180 Average:37637.23 Median:27360.59 stddev:119788.58 (437.8%) stddev-sans-first:120091.83 10:07:31 INFO - PROCESS | 1952 | Values: 309.7 318.5 358.9 360.9 371.2 13223.9 15431.7 15717.2 19126.8 20550.9 11693.6 12103.2 15496.4 20013.0 20013.5 5178.0 5368.4 5372.4 5372.5 5378.3 3913.2 4097.9 5368.3 5416.3 5417.9 4106.1 4109.4 4111.0 4111.5 7277.7 7200.2 7487.6 7502.3 7506.4 7511.4 6946.6 7098.0 7128.6 7163.2 7165.6 25551.9 26522.9 26561.9 26908.7 26932.6 2172.2 2435.1 2621.8 2821.7 2827.3 15246.8 15867.8 16059.6 16185.8 16408.6 1852.4 1902.3 1915.1 1932.5 1957.3 73198.0 80632.0 103484.5 104247.4 108003.0 15625.2 18007.7 18479.7 18903.0 19072.7 27788.6 28077.0 28160.3 28161.3 28192.7 10352.0 10355.4 10434.3 10445.9 10523.4 8797.4 8840.7 8843.1 8924.4 8932.6 7428.0 8623.4 8647.0 8735.2 8823.0 1861.7 1883.2 1905.2 2237.4 3238.3 840.7 918.4 924.0 957.5 976.4 16441.0 19206.5 20350.8 20615.5 20865.3 886.8 893.8 908.1 951.6 989.0 10046.0 10943.3 10945.7 11051.2 11081.7 694627.0 698654.5 730566.0 759561.0 760067.4 86140.0 114122.0 114363.0 117065.7 117483.0 1099.3 1143.0 1156.7 1158.5 1159.3 18385.9 18704.3 18752.6 18793.6 18848.5 46675.8 47393.3 47555.0 49015.8 50013.0 67887.3 68222.3 69121.7 69418.7 69869.0 7212.3 7540.3 7629.2 7632.9 7710.8 7951.0 9378.9 11713.5 11827.6 12059.6 9294.4 10365.4 10529.9 10531.9 10799.1 10393.7 10530.4 10548.9 10759.1 10867.9 10218.0 10454.5 10602.0 10802.0 10936.0 7484.1 7638.7 7640.5 7686.2 7711.2 10080.8 10696.5 10863.1 10872.6 10975.3 10:07:31 INFO - PROCESS | 1952 | 10:07:31 INFO - PROCESS | 1952 | [#3] mootools.html Cycles:180 Average:6072.29 Median:5069.79 stddev:3181.80 (62.8%) stddev-sans-first:3171.22 10:07:31 INFO - PROCESS | 1952 | Values: 1386.6 1510.8 1530.4 1770.9 1943.1 7870.0 8512.9 8647.7 8650.4 8661.6 8273.0 8501.9 8561.3 8563.2 8564.4 2183.1 2226.9 2439.4 2480.8 2515.5 2471.2 2500.8 2505.0 2505.5 2506.3 2460.3 2498.1 2502.3 2506.9 2513.6 2415.9 2479.7 2479.9 2481.4 2488.0 2068.7 2395.8 2430.9 2450.9 2451.9 8716.3 8795.6 8797.0 8805.7 8830.4 5412.2 5566.7 5572.6 5577.2 5578.4 3668.8 3707.0 3776.5 3778.5 3787.5 1042.1 1048.1 1062.4 1093.9 1112.1 11896.3 11898.2 11906.4 11916.9 11933.2 4925.5 4947.6 5020.2 5067.3 5072.3 10310.1 10319.1 10333.5 10334.5 10340.9 5562.0 5568.0 5568.9 5572.1 5575.8 4896.9 5044.7 5048.9 5052.6 5053.1 3711.1 3788.4 3788.5 3803.0 3803.3 1298.1 1331.9 1339.8 1344.4 1352.2 1092.5 1104.1 1111.1 1242.9 1350.7 6877.4 8026.5 8187.1 8191.3 8209.8 1168.8 1169.7 1174.6 1187.3 1195.3 6203.9 6226.1 6298.3 6302.4 6315.3 10488.9 10738.1 10879.0 10886.2 10894.8 10458.3 10611.8 10624.7 10732.7 10739.0 6679.9 8228.3 8306.8 8310.2 8312.0 7797.6 7821.0 7868.0 7889.2 7899.8 9517.9 9613.5 9633.5 9645.4 9747.2 9715.7 9886.2 9968.3 10032.7 10153.3 7145.6 7504.4 7528.9 7594.5 7594.7 7463.4 7641.1 8180.6 8289.2 8378.0 7589.8 7590.2 7644.1 7795.5 7803.6 7457.9 7506.6 7581.1 7626.3 7639.9 7557.1 7645.3 7654.1 7692.0 7703.2 6968.7 7010.3 7013.4 7015.1 7021.9 6883.7 7022.1 7039.1 7073.8 7079.6 10:07:31 INFO - PROCESS | 1952 | 10:07:31 INFO - PROCESS | 1952 | [#4] prototype.html Cycles:180 Average:5827.68 Median:6580.96 stddev:1848.61 (28.1%) stddev-sans-first:1806.99 10:07:31 INFO - PROCESS | 1952 | Values: 320.4 324.6 329.6 333.3 337.4 6662.1 6696.8 6705.6 6742.6 6760.8 6651.1 6726.8 6730.2 6740.7 6761.3 4939.0 4940.9 4945.4 4947.6 4961.8 4182.7 4832.2 4840.7 4845.6 4848.7 4793.3 4805.5 4818.9 4837.8 4840.6 4627.8 4735.3 4744.6 4839.1 4865.8 3293.8 4032.3 4036.2 4037.7 4038.8 6190.4 6510.3 6511.1 6518.7 6524.1 5637.3 5645.3 5652.1 5655.6 5666.5 6124.7 6451.2 7147.8 7155.9 7162.3 4665.2 4761.1 4767.3 4776.5 4790.1 7324.5 7532.7 7556.9 7563.2 7563.9 4864.0 4868.4 4876.9 4877.3 4885.8 4933.6 4944.7 4945.3 4954.3 4963.7 5587.3 5684.5 5693.3 5698.2 5900.7 6970.4 7093.3 7115.1 7239.7 7260.5 1670.9 1702.6 1716.3 1716.7 1717.7 1087.1 1102.7 1117.9 1124.1 1136.0 6033.2 6550.1 6569.4 6594.7 6595.0 5992.0 7411.6 7415.5 7418.6 7424.0 6339.8 6571.3 6590.6 6591.9 6612.1 3913.6 3935.1 3942.1 3942.3 3950.2 7636.8 7668.4 7685.0 7704.8 7705.3 7280.7 7615.9 7623.8 7624.1 7637.5 7654.5 7663.3 7672.1 7675.0 7683.2 6569.9 6852.2 7380.5 7385.2 7387.5 5794.7 7174.2 7254.7 7256.7 7276.7 7643.5 7646.5 7652.8 7667.0 7677.8 4891.8 4898.3 4901.4 4910.2 4914.0 7038.0 7094.3 7258.9 7340.1 7349.7 6982.7 7026.8 7030.3 7237.6 7247.5 5911.8 7218.8 7251.5 7254.5 7263.5 6817.9 7043.3 7046.9 7048.7 7073.0 7240.3 7252.8 7270.7 7273.9 7274.6 6868.9 7102.9 7113.5 7114.1 7116.7 10:07:31 INFO - PROCESS | 1952 | 10:07:31 INFO - PROCESS | 1952 | [#5] yui.html Cycles:180 Average:18092.38 Median:616.69 stddev:25097.11 (4069.6%) stddev-sans-first:25133.35 10:07:31 INFO - PROCESS | 1952 | Values: 652.5 657.1 683.8 718.8 783.3 14490.6 14697.0 14703.0 14707.5 14717.4 13249.3 13327.3 13340.3 13384.7 13398.7 835.5 850.9 851.4 852.1 854.0 695.1 702.6 847.9 849.8 851.1 876.2 885.2 886.8 887.3 912.5 714.9 725.3 884.0 888.2 906.8 654.0 656.0 656.4 656.6 662.0 14512.1 14563.3 14565.8 14580.7 14591.7 12499.8 12652.2 12733.8 12799.7 12804.6 10024.9 10026.6 10133.0 10175.8 10203.2 2975.5 3473.6 3673.4 3698.1 3711.6 83382.6 84966.6 88087.6 88239.0 88609.0 9610.3 9671.4 9734.5 9737.8 9746.2 21608.7 21738.6 21756.3 21763.3 21780.5 7538.6 7542.7 7609.4 7615.2 7703.1 4137.9 4138.2 4147.3 4190.4 4217.0 3482.1 3509.5 3510.9 3517.7 3522.6 616.5 628.1 629.7 637.3 638.2 573.3 594.9 614.6 616.9 628.8 8348.9 9091.9 9229.1 9455.4 9476.8 494.5 585.2 598.9 599.7 609.2 3646.3 3715.0 3753.0 3973.7 4052.1 86190.6 87183.1 87497.0 87575.6 87787.0 68763.7 68895.7 69891.3 70016.0 70925.6 57129.0 57626.6 62541.0 62746.0 65299.1 7689.6 8851.4 9038.8 9102.9 9314.1 50321.2 53266.7 53962.5 56862.1 57616.7 68898.0 70571.0 70577.6 72213.9 73621.0 11258.4 11519.1 11634.6 11637.5 12336.8 11997.2 12008.6 12018.0 12035.3 12041.4 11424.3 11432.5 11434.1 11444.0 11488.1 11490.9 11492.1 11495.3 11495.8 11537.4 11306.7 11318.9 11320.9 11324.0 11329.3 8077.4 9236.7 9575.3 9847.1 9848.9 9900.7 9915.9 9938.9 9949.0 9966.5 10:07:31 INFO - PROCESS | 1952 | -------- Summary: end -------- 10:07:31 INFO - PROCESS | 1952 | 10:07:32 INFO - TEST-INFO | 1952: exit 0 10:07:32 INFO - TEST-OK | dromaeo_css | took 1115201ms 10:07:32 INFO - TEST-START | kraken 10:07:32 INFO - operating with platform_type : mac_ 10:07:32 INFO - Initialising browser for kraken test... 10:07:32 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmp0TiwaD/profile http://localhost:49450/getInfo.html) 10:07:34 INFO - PROCESS | 1958 | __metrics Screen width/height:1600/1200 10:07:34 INFO - PROCESS | 1958 | colorDepth:24 10:07:34 INFO - PROCESS | 1958 | Browser inner width/height: 1024/689 10:07:34 INFO - PROCESS | 1958 | __metrics 10:07:34 INFO - PROCESS | 1958 | 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" 10:07:34 INFO - PROCESS | 1958 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:07:35 INFO - TEST-INFO | 1958: exit 0 10:07:35 INFO - Browser initialized. 10:07:35 INFO - Running cycle 1/1 for kraken test... 10:07:35 INFO - TEST-INFO | started process 1961 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmp0TiwaD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:47 INFO - PROCESS | 1961 | RSS: Main: 246046720 10:07:47 INFO - PROCESS | 1961 | 10:07:49 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49450/tests/kraken/driver.html?testName=audio-beat-detection) 10:07:50 INFO - PROCESS | 1961 | RSS: Main: 291360768 10:07:50 INFO - PROCESS | 1961 | 10:07:52 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49450/tests/kraken/driver.html?testName=audio-dft) 10:07:53 INFO - PROCESS | 1961 | RSS: Main: 303931392 10:07:53 INFO - PROCESS | 1961 | 10:07:57 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49450/tests/kraken/driver.html?testName=audio-fft) 10:07:57 INFO - PROCESS | 1961 | RSS: Main: 286498816 10:07:57 INFO - PROCESS | 1961 | 10:07:59 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49450/tests/kraken/driver.html?testName=audio-oscillator) 10:08:00 INFO - PROCESS | 1961 | RSS: Main: 289591296 10:08:00 INFO - PROCESS | 1961 | 10:08:02 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49450/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:08:02 INFO - PROCESS | 1961 | RSS: Main: 290115584 10:08:02 INFO - PROCESS | 1961 | 10:08:05 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49450/tests/kraken/driver.html?testName=imaging-darkroom) 10:08:06 INFO - PROCESS | 1961 | RSS: Main: 291090432 10:08:06 INFO - PROCESS | 1961 | 10:08:09 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49450/tests/kraken/driver.html?testName=imaging-desaturate) 10:08:09 INFO - PROCESS | 1961 | RSS: Main: 290455552 10:08:09 INFO - PROCESS | 1961 | 10:08:12 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49450/tests/kraken/driver.html?testName=json-parse-financial) 10:08:13 INFO - PROCESS | 1961 | RSS: Main: 289886208 10:08:13 INFO - PROCESS | 1961 | 10:08:14 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49450/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:08:15 INFO - PROCESS | 1961 | RSS: Main: 323563520 10:08:15 INFO - PROCESS | 1961 | 10:08:16 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:08:17 INFO - PROCESS | 1961 | RSS: Main: 324898816 10:08:17 INFO - PROCESS | 1961 | 10:08:19 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:08:20 INFO - PROCESS | 1961 | RSS: Main: 333615104 10:08:20 INFO - PROCESS | 1961 | 10:08:22 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:08:23 INFO - PROCESS | 1961 | RSS: Main: 333774848 10:08:23 INFO - PROCESS | 1961 | 10:08:25 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:08:26 INFO - PROCESS | 1961 | RSS: Main: 334991360 10:08:26 INFO - PROCESS | 1961 | 10:08:28 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49450/tests/kraken/driver.html?testName=ai-astar) 10:08:28 INFO - PROCESS | 1961 | RSS: Main: 395018240 10:08:28 INFO - PROCESS | 1961 | 10:08:28 INFO - PROCESS | 1961 | __start_tp_report 10:08:28 INFO - PROCESS | 1961 | _x_x_mozilla_page_load 10:08:28 INFO - PROCESS | 1961 | _x_x_mozilla_page_load_details 10:08:28 INFO - PROCESS | 1961 | |i|pagename|runs| 10:08:28 INFO - PROCESS | 1961 | |0;ai-astar;110;109;110;111;111;112;117;112;111;111 10:08:28 INFO - PROCESS | 1961 | |1;audio-beat-detection;177;146;146;160;121;142;141;133;192;119 10:08:28 INFO - PROCESS | 1961 | |2;audio-dft;187;213;267;263;184;186;184;181;177;181 10:08:28 INFO - PROCESS | 1961 | |3;audio-fft;76;72;87;79;57;58;58;76;78;77 10:08:28 INFO - PROCESS | 1961 | |4;audio-oscillator;93;95;128;78;80;93;108;76;79;106 10:08:28 INFO - PROCESS | 1961 | |5;imaging-gaussian-blur;86;91;85;90;86;89;85;93;127;91 10:08:28 INFO - PROCESS | 1961 | |6;imaging-darkroom;95;94;95;94;95;94;95;94;95;101 10:08:28 INFO - PROCESS | 1961 | |7;imaging-desaturate;85;85;84;84;85;88;84;100;134;85 10:08:28 INFO - PROCESS | 1961 | |8;json-parse-financial;57;54;54;55;53;54;55;64;53;52 10:08:28 INFO - PROCESS | 1961 | |9;json-stringify-tinderbox;65;63;77;74;68;66;67;66;67;67 10:08:28 INFO - PROCESS | 1961 | |10;stanford-crypto-aes;83;94;104;83;89;81;82;82;83;83 10:08:28 INFO - PROCESS | 1961 | |11;stanford-crypto-ccm;132;125;125;124;136;109;127;123;128;120 10:08:28 INFO - PROCESS | 1961 | |12;stanford-crypto-pbkdf2;134;128;142;141;137;140;139;138;137;135 10:08:28 INFO - PROCESS | 1961 | |13;stanford-crypto-sha256-iterative;66;68;71;68;67;66;66;67;66;66 10:08:28 INFO - PROCESS | 1961 | __end_tp_report 10:08:28 INFO - PROCESS | 1961 | __start_cc_report 10:08:28 INFO - PROCESS | 1961 | _x_x_mozilla_cycle_collect,1167 10:08:28 INFO - PROCESS | 1961 | __end_cc_report 10:08:28 INFO - PROCESS | 1961 | __startTimestamp1455127708528__endTimestamp 10:08:28 INFO - PROCESS | 1961 | 10:08:28 INFO - PROCESS | 1961 | ------- Summary: start ------- 10:08:28 INFO - PROCESS | 1961 | Number of tests: 14 10:08:28 INFO - PROCESS | 1961 | 10:08:28 INFO - PROCESS | 1961 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:2.17 (2.0%) stddev-sans-first:2.24 10:08:28 INFO - PROCESS | 1961 | Values: 110.0 109.0 110.0 111.0 111.0 112.0 117.0 112.0 111.0 111.0 10:08:28 INFO - PROCESS | 1961 | 10:08:28 INFO - PROCESS | 1961 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:146.00 stddev:23.11 (15.8%) stddev-sans-first:21.95 10:08:28 INFO - PROCESS | 1961 | Values: 177.0 146.0 146.0 160.0 121.0 142.0 141.0 133.0 192.0 119.0 10:08:28 INFO - PROCESS | 1961 | 10:08:28 INFO - PROCESS | 1961 | [#2] audio-dft Cycles:10 Average:202.30 Median:186.50 stddev:34.48 (18.5%) stddev-sans-first:36.13 10:08:28 INFO - PROCESS | 1961 | Values: 187.0 213.0 267.0 263.0 184.0 186.0 184.0 181.0 177.0 181.0 10:08:28 INFO - PROCESS | 1961 | 10:08:28 INFO - PROCESS | 1961 | [#3] audio-fft Cycles:10 Average:71.80 Median:76.50 stddev:10.45 (13.7%) stddev-sans-first:10.98 10:08:28 INFO - PROCESS | 1961 | Values: 76.0 72.0 87.0 79.0 57.0 58.0 58.0 76.0 78.0 77.0 10:08:28 INFO - PROCESS | 1961 | 10:08:28 INFO - PROCESS | 1961 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:79.50 stddev:16.66 (21.0%) stddev-sans-first:17.67 10:08:28 INFO - PROCESS | 1961 | Values: 93.0 95.0 128.0 78.0 80.0 93.0 108.0 76.0 79.0 106.0 10:08:28 INFO - PROCESS | 1961 | 10:08:28 INFO - PROCESS | 1961 | [#5] imaging-gaussian-blur Cycles:10 Average:92.30 Median:89.50 stddev:12.52 (14.0%) stddev-sans-first:13.07 10:08:28 INFO - PROCESS | 1961 | Values: 86.0 91.0 85.0 90.0 86.0 89.0 85.0 93.0 127.0 91.0 10:08:28 INFO - PROCESS | 1961 | 10:08:28 INFO - PROCESS | 1961 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:95.00 stddev:2.10 (2.2%) stddev-sans-first:2.22 10:08:28 INFO - PROCESS | 1961 | Values: 95.0 94.0 95.0 94.0 95.0 94.0 95.0 94.0 95.0 101.0 10:08:28 INFO - PROCESS | 1961 | 10:08:28 INFO - PROCESS | 1961 | [#7] imaging-desaturate Cycles:10 Average:91.40 Median:85.00 stddev:15.74 (18.5%) stddev-sans-first:16.52 10:08:28 INFO - PROCESS | 1961 | Values: 85.0 85.0 84.0 84.0 85.0 88.0 84.0 100.0 134.0 85.0 10:08:28 INFO - PROCESS | 1961 | 10:08:28 INFO - PROCESS | 1961 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:54.50 stddev:3.41 (6.3%) stddev-sans-first:3.55 10:08:28 INFO - PROCESS | 1961 | Values: 57.0 54.0 54.0 55.0 53.0 54.0 55.0 64.0 53.0 52.0 10:08:28 INFO - PROCESS | 1961 | 10:08:28 INFO - PROCESS | 1961 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:67.00 stddev:4.24 (6.3%) stddev-sans-first:4.36 10:08:28 INFO - PROCESS | 1961 | Values: 65.0 63.0 77.0 74.0 68.0 66.0 67.0 66.0 67.0 67.0 10:08:28 INFO - PROCESS | 1961 | 10:08:28 INFO - PROCESS | 1961 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:83.00 stddev:7.37 (8.9%) stddev-sans-first:7.71 10:08:28 INFO - PROCESS | 1961 | Values: 83.0 94.0 104.0 83.0 89.0 81.0 82.0 82.0 83.0 83.0 10:08:28 INFO - PROCESS | 1961 | 10:08:28 INFO - PROCESS | 1961 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:126.00 stddev:7.22 (5.7%) stddev-sans-first:7.18 10:08:28 INFO - PROCESS | 1961 | Values: 132.0 125.0 125.0 124.0 136.0 109.0 127.0 123.0 128.0 120.0 10:08:28 INFO - PROCESS | 1961 | 10:08:28 INFO - PROCESS | 1961 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.10 Median:138.50 stddev:4.07 (2.9%) stddev-sans-first:4.16 10:08:28 INFO - PROCESS | 1961 | Values: 134.0 128.0 142.0 141.0 137.0 140.0 139.0 138.0 137.0 135.0 10:08:28 INFO - PROCESS | 1961 | 10:08:28 INFO - PROCESS | 1961 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.60 (2.4%) stddev-sans-first:1.64 10:08:28 INFO - PROCESS | 1961 | Values: 66.0 68.0 71.0 68.0 67.0 66.0 66.0 67.0 66.0 66.0 10:08:28 INFO - PROCESS | 1961 | -------- Summary: end -------- 10:08:28 INFO - PROCESS | 1961 | 10:08:29 INFO - TEST-INFO | 1961: exit 0 10:08:29 INFO - TEST-OK | kraken | took 56924ms 10:08:29 INFO - SUITE-END | took 1172s 10:08:29 INFO - Completed test suite (00:19:32) 10:08:29 INFO - Working with test: dromaeo_css 10:08:29 INFO - Generating results file: dromaeo_css 10:08:29 INFO - Working with test: kraken 10:08:29 INFO - Generating results file: kraken 10:08:29 INFO - javascript benchmark 10:08:29 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:08:29 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 10:08:29 INFO - process_Request line: dromaeo_css 7618.21 graph.html#tests=[[72,1,59]] 10:08:29 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:08:29 INFO - process_Request line: kraken 1444.30 graph.html#tests=[[232,1,59]] 10:08:29 INFO - RETURN: dromaeo_css: 7618.21 10:08:29 INFO - RETURN: kraken: 1444.30 10:08:29 INFO - javascript benchmark 10:08:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3207.7433805295577, 3510.192655689192, 3517.402041652919, 3518.190816112294, 3576.2668652926154, 5616.775328986836, 5708.800191993281, 5747.655140691556, 5760.193572899792, 5765.3369862465825, 5725.227094342263, 5752.626079304852, 5852.326982397026, 5872.500837428824, 5903.055511118222, 5096.949030509703, 5131.102057140004, 5151.639385243035, 5164.4060932992625, 5284.075286824809, 5275.208718692208, 5305.840824775243, 5316.0, 5323.281357016792, 5359.866003349908, 5132.692038477685, 5204.323437953042, 5215.1134307167495, 5226.555742761831, 5273.815416460425, 5135.74321283938, 5217.686938783647, 5225.425203227642, 5251.028559716465, 5306.071437498423, 4285.550017248175, 5218.373795144607, 5218.930119325529, 5241.8165364212455, 5247.763850626731, 5631.2960879890015, 5710.114932185518, 5719.113537401709, 5727.341355744101, 5750.770148067202, 6158.815235542941, 6196.411340922605, 6277.87444251117, 6303.0, 6310.211223597051, 5451.945480545223, 6308.779192728232, 6312.116303717483, 6314.589551679126, 6336.46140078094, 5270.130428479335, 5763.769449221984, 5814.069748840166, 5846.824595262149, 5854.034084376115, 6234.220722409699, 6237.313895471494, 6313.3686631336495, 6324.620522768557, 6338.873222535616, 6204.410580994799, 6207.34822843604, 6217.533684973645, 6241.313455519889, 6253.530985176039, 6172.105044768484, 6293.748250070037, 6295.905561416583, 6306.842328941813, 6325.9051114233325, 6174.166487524217, 6227.377262273827, 6295.811125666238, 6312.715927783261, 6316.747330106836, 6286.088517165077, 6292.622442653455, 6313.842153946188, 6317.684115794192, 6320.936790632127, 4869.318295438641, 4906.386701662293, 4944.3572335596145, 4964.975175124174, 5004.099262132779, 4462.933056004163, 4488.192125417391, 4502.617277531381, 4503.932441013388, 4527.501974782771, 5714.571407144481, 5732.3121225453215, 5733.369329373765, 5736.913946290809, 5739.196512488255, 6203.7828675996125, 6265.8746825063245, 6272.18461599989, 6275.215598050244, 6309.211348581427, 5711.286089238845, 5760.596758226968, 5768.596198266165, 5776.566757493205, 5800.622959507703, 5295.920561191585, 5417.18742188667, 5421.430749771296, 5434.266374039454, 5435.211894275387, 6324.462420694293, 6328.240611126602, 6401.935980640134, 6415.486761059104, 6423.646699431482, 6272.40412160844, 6295.96852015737, 6310.368963103837, 6320.5891617044745, 6325.1144839721555, 6241.3134555197985, 6314.810555683153, 6390.872182556416, 6403.2316122063785, 6415.0, 5772.538196944319, 5806.618253345299, 6176.258848938156, 6281.497480201664, 6310.463610593151, 5785.363610002981, 5852.712403271274, 6286.088517165077, 6297.307296197323, 6335.1130841683125, 6055.2733671957885, 6111.470193407107, 6118.724657390517, 6159.538034647509, 6190.969045154746, 6025.6083354581815, 6097.664628445478, 6104.969475152596, 6111.602745821508, 6126.0, 5877.441643043904, 5932.436418540232, 5934.465898069195, 5939.109133629817, 5953.613015154175, 6059.242594675666, 6111.419415155553, 6121.785737499166, 6169.629822210682, 6175.96912015437, 6058.242719660043, 6061.030235162353, 6077.787277445268, 6107.84730381744, 6107.877842443215], "unit": "score", "name": "dojo.html", "value": 5726.895285458561}, {"lowerIsBetter": false, "replicates": [438.8573713543099, 451.1608408360451, 472.2727000419354, 535.5715427657873, 586.6509426891, 29118.854405727994, 36798.44802327964, 37837.43243851337, 37946.81026594863, 38019.429708554395, 40208.59791402085, 40512.392314115314, 40700.59299407005, 40796.38805417921, 40852.18295634093, 9523.761905952355, 9722.90277097227, 9726.756831079245, 9749.122578967892, 9753.463559504224, 9452.95273523635, 9582.0, 9583.424994500352, 9591.232701383873, 9597.904020959772, 9547.522623868814, 9629.951850240739, 9630.759231019245, 9634.47010414427, 9642.951785241099, 9545.284103692216, 9604.279679024101, 9611.519424028771, 9616.615335386576, 9640.758981025496, 9445.858312125323, 9563.378380405251, 9572.282078844115, 9577.569009394594, 9580.712578622582, 34129.317413651836, 36585.81707091474, 38397.0, 38834.02914927121, 38850.61149388498, 3096.5664806927048, 3160.083575763026, 3160.1783536280504, 3199.104250809777, 3376.797392156454, 27997.300067498272, 28287.0, 28683.0, 28805.99179028724, 29520.70479295201, 2719.714429984863, 2723.945521089567, 2736.822106563067, 2872.2819295176205, 2944.440556294297, 403752.0, 404721.0, 405032.0, 405224.0, 405937.97031014954, 53345.0, 54657.45342546603, 56750.7162464185, 61069.69465152646, 65782.0, 50669.49330506721, 62645.0, 62985.68507157435, 63021.05468417978, 63141.68429157825, 15479.5356139316, 15700.371985120468, 15714.0, 15741.055536667836, 15743.527694169194, 9750.0, 10973.177011724152, 11137.721556961142, 12103.697407564705, 12175.939120304341, 20014.799852001586, 20281.898590506953, 20300.695489567668, 20327.695084573745, 20329.593408132052, 8838.469691818511, 8874.968928660204, 9116.498592577473, 9128.26973842091, 9207.217386522221, 963.9277054220961, 999.2106236073566, 999.3604093380243, 1052.3685788526975, 1084.2681190196586, 28440.573391399146, 28808.855955720086, 29239.01585217869, 29649.110526684235, 29692.257693557403, 1038.039813172812, 1049.3913530152493, 1065.5471424644495, 1083.8482612434266, 1087.907527860125, 13452.730945381234, 14057.297135143202, 14164.008519403544, 14403.351849166604, 14440.638984025274, 635244.0, 652449.0, 653054.0, 653200.0, 653815.0, 55093.347199584074, 55470.72264638651, 55502.0, 55639.60900977427, 55828.72085639627, 1408.9929550352388, 1420.240171508238, 1434.7202295552477, 1439.8920080993757, 1439.964000899944, 27723.40287902206, 28080.29799255035, 28086.43827123487, 28099.859500702365, 28102.43795124127, 46114.0, 46671.0, 46692.7665361671, 46709.29936050894, 46820.0, 492211.0, 509735.0, 524126.379368116, 529944.0, 533615.0, 31075.980061296847, 31202.843985779928, 31307.84346078255, 31385.215369615944, 31502.684973150892, 40001.59998399979, 40355.79822100871, 40574.79712601418, 41003.76988690344, 41541.0, 34173.82913085419, 35025.64974350224, 35275.64724352724, 35277.64722352846, 39795.0, 37152.81423592865, 37294.62705372911, 37605.24789504249, 38013.0, 38118.61881381151, 37681.43477847889, 38085.80957095197, 38128.23743525169, 38211.61788382192, 39269.803650981565, 33826.49260261147, 36428.81785591055, 37573.62426375701, 37823.05442363963, 38164.0, 24978.500429990934, 25946.481070378864, 26031.349216269744, 26038.218853434428, 26771.598426023236], "unit": "score", "name": "ext.html", "value": 19461.083958610572}, {"lowerIsBetter": false, "replicates": [309.7166093024882, 318.5190362552545, 358.8564574170333, 360.868283076677, 371.1945079178183, 13223.867761322384, 15431.69136617267, 15717.20800279397, 19126.808731912675, 20550.89724551377, 11693.649190524298, 12103.21329113607, 15496.380144794222, 20012.999350032514, 20013.499662508446, 5177.990291893073, 5368.409474957752, 5372.435894231108, 5372.489613486712, 5378.327709036371, 3913.1977944521445, 4097.877063688079, 5368.275282836806, 5416.268803711508, 5417.864553386157, 4106.096658735073, 4109.4041364002205, 4110.97944510277, 4111.506619205699, 7277.672504737299, 7200.171980222263, 7487.588182649952, 7502.287282708134, 7506.399488040998, 7511.399088072995, 6946.6179360135175, 7097.964510177416, 7128.6435678215885, 7163.1762347330205, 7165.6417179140835, 25551.85016674254, 26522.86738566314, 26561.867190664118, 26908.73091269082, 26932.59601105985, 2172.2397160993683, 2435.1233555919853, 2621.829581077243, 2821.6614006319373, 2827.2790438438274, 15246.847531524654, 15867.841321586751, 16059.598510037225, 16185.757213641804, 16408.589785255463, 1852.3609354772582, 1902.296150424338, 1915.1190452391777, 1932.468571142933, 1957.2660252405349, 73198.0, 80632.0, 103484.48257758738, 104247.43628845573, 108003.0, 15625.218739063, 18007.72988405175, 18479.722804157947, 18903.0, 19072.71390929137, 27788.58317125245, 28077.0, 28160.29599259994, 28161.295967600974, 28192.718072819418, 10352.0, 10355.43045132525, 10434.321769084985, 10445.895541044492, 10523.368597884151, 8797.38418310725, 8840.734777956672, 8843.0714774949, 8924.375293729376, 8932.553372331358, 7428.034355533746, 8623.353248506388, 8646.956765216133, 8735.213830755136, 8822.985356683936, 1861.6835138026568, 1883.2278765705994, 1905.199356945316, 2237.351168161215, 3238.2875767331147, 840.7015509494164, 918.3755046568264, 923.9630414783468, 957.4686049242737, 976.4043933200742, 16441.0, 19206.519837004187, 20350.796492035188, 20615.45384096199, 20865.269715559883, 886.7605746448423, 893.7631527645179, 908.0601577367393, 951.6003278622995, 988.9950550247203, 10046.0, 10943.28868623537, 10945.671629851116, 11051.226414150933, 11081.667549973514, 694627.0, 698654.5067274631, 730566.0, 759561.0, 760067.3959562444, 86140.0, 114122.0, 114363.0, 117065.71928986491, 117483.0, 1099.3074363151163, 1142.9828552571719, 1156.6587856582328, 1158.4902642837126, 1159.2580748320913, 18385.90807045956, 18704.345347912757, 18752.62494750125, 18793.590480714276, 18848.52878678044, 46675.83310417267, 47393.28910066283, 47555.0, 49015.75492122517, 50013.0, 67887.32112679008, 68222.3177768216, 69121.65439172772, 69418.65290673514, 69869.0, 7212.3148300911325, 7540.265738880198, 7629.16079231273, 7632.89323048166, 7710.7686769397005, 7950.960245198969, 9378.906210937803, 11713.531458741554, 11827.586034489095, 12059.57791477294, 9294.395864268801, 10365.360071115325, 10529.894701053197, 10531.947340263556, 10799.082078023455, 10393.740156496147, 10530.42082685429, 10548.947255263674, 10759.085477734166, 10867.891321087005, 10218.029287217703, 10454.477276136315, 10602.0, 10802.0, 10936.0, 7484.064491938508, 7638.732644357421, 7640.503367281109, 7686.154523002577, 7711.228877112244, 10080.798384032425, 10696.465176741287, 10863.130949524177, 10872.565097396331, 10975.341479511255], "unit": "score", "name": "jquery.html", "value": 9936.217499719394}, {"lowerIsBetter": false, "replicates": [1386.5978866128823, 1510.7582786754117, 1530.4337395163784, 1770.8937463752177, 1943.0673276827122, 7869.960650196748, 8512.872306915393, 8647.69733059343, 8650.43772154811, 8661.610227539752, 8273.04859941107, 8501.872471912926, 8561.315094792417, 8563.229309362156, 8564.357673174522, 2183.094015983365, 2226.908814680811, 2439.3657649011207, 2480.776730094291, 2515.5094756522485, 2471.221565206963, 2500.7874330681916, 2504.9749502504924, 2505.498900219954, 2506.320765087387, 2460.2619214235747, 2498.1381423408893, 2502.2618327593405, 2506.887190076442, 2513.622956556522, 2415.867127307997, 2479.7396273391214, 2479.9132030379033, 2481.4416756229884, 2488.0172331928966, 2068.7414073240843, 2395.7604239575903, 2430.927072187837, 2450.8774561271866, 2451.889664965081, 8716.302695784321, 8795.60419781105, 8796.956015219946, 8805.735827925173, 8830.381873268874, 5412.242286079952, 5566.721663916788, 5572.637778544382, 5577.2191893135, 5578.386377498472, 3668.761530500509, 3707.017640325316, 3776.4901738265257, 3778.471014058034, 3787.4697542344093, 1042.0933787604831, 1048.09863517375, 1062.3944351719524, 1093.8632670916136, 1112.0825319111684, 11896.345700986441, 11898.22661526998, 11906.404679765978, 11916.880831191751, 11933.224340417844, 4925.532074452921, 4947.60419166473, 5020.221865610836, 5067.315912351859, 5072.264521644341, 10310.07209351147, 10319.071283584513, 10333.48332583383, 10334.534945927451, 10340.948295258626, 5561.971035358471, 5568.0, 5568.888622227532, 5572.0527510323345, 5575.776968921279, 4896.853094407174, 5044.747762611854, 5048.949510504848, 5052.646314758005, 5053.140966035783, 3711.0536813112485, 3788.431735239736, 3788.5453745550712, 3803.0, 3803.2583646188727, 1298.1497119386818, 1331.863416959656, 1339.8057281694294, 1344.3815844711346, 1352.1886867879193, 1092.5192915117323, 1104.0505165557613, 1111.105560024172, 1242.937853107341, 1350.7433587618518, 6877.415419689282, 8026.478278911852, 8187.0994190638985, 8191.303739182236, 8209.753707388787, 1168.8013037783596, 1169.7309618787726, 1174.6065068202247, 1187.2935603316187, 1195.3186683590443, 6203.875922481525, 6226.066090086523, 6298.338674439118, 6302.432781049728, 6315.273743519462, 10488.947555262328, 10738.140948724084, 10878.96649818266, 10886.23796334249, 10894.782104357868, 10458.320209186379, 10611.84082238767, 10624.681259562225, 10732.73168170802, 10739.033486986209, 6679.86640267192, 8228.25945664893, 8306.750797476085, 8310.21052999964, 8311.99999999988, 7797.571133587707, 7820.983272174809, 7868.0, 7889.211078892295, 7899.84200315979, 9517.904820951702, 9613.51932403363, 9633.470159141314, 9645.37305075168, 9747.220222382051, 9715.708528743866, 9886.159676427584, 9968.252381071303, 10032.69901902944, 10153.289269751047, 7145.606991615511, 7504.399648028036, 7528.924710752823, 7594.468387212842, 7594.734184303523, 7463.402927765657, 7641.121271053677, 8180.550069746221, 8289.171082891662, 8378.0, 7589.848203036019, 7590.203028681909, 7644.120926093348, 7795.493292935941, 7803.648835802516, 7457.850842983002, 7506.624668766431, 7581.128170260491, 7626.275503827128, 7639.923600764144, 7557.093148822177, 7645.273698998586, 7654.119776225805, 7692.000039994765, 7703.152653208031, 6968.721251149897, 7010.263922288086, 7013.4038606719005, 7015.052967849275, 7021.859562808613, 6883.655817209019, 7022.052022977037, 7039.120109986252, 7073.787786366417, 7079.646017699198], "unit": "score", "name": "mootools.html", "value": 4956.072335806463}, {"lowerIsBetter": false, "replicates": [320.4200397280921, 324.5650827890626, 329.5748484455052, 333.30339590256347, 337.36070147071314, 6662.100616416782, 6696.7990960271145, 6705.631190284533, 6742.629155396451, 6760.763373281936, 6651.068850360941, 6726.764563240287, 6730.158730158731, 6740.66296685165, 6761.256261811209, 4938.975305123478, 4940.851774446773, 4945.431275403339, 4947.604191664676, 4961.8015279388965, 4182.707210495267, 4832.178529649968, 4840.661153719241, 4845.636577256702, 4848.7090774553635, 4793.2810078488155, 4805.495422980589, 4818.879528011793, 4837.782299796518, 4840.6369522285795, 4627.768611569408, 4735.337052812609, 4744.620430365562, 4839.128956787777, 4865.781039853197, 3293.818839963801, 4032.3145065338963, 4036.1524079942956, 4037.7173597848164, 4038.7980600970127, 6190.442860142563, 6510.251321098087, 6511.088447617338, 6518.739250429977, 6524.11924390206, 5637.3235211774845, 5645.266115404971, 5652.123920792284, 5655.632383895075, 5666.46168613981, 6124.7138100998845, 6451.161349024644, 7147.785566433015, 7155.856882862314, 7162.319579639926, 4665.227213658822, 4761.095391875532, 4767.332573439721, 4776.498467660915, 4790.089882922233, 7324.48728588999, 7532.661030253597, 7556.866470029485, 7563.168051514329, 7563.924360756432, 4864.0, 4868.415790105139, 4876.8780780480065, 4877.268409738496, 4885.8289959851945, 4933.555979961749, 4944.703317800943, 4945.258211268267, 4954.3063971044085, 4963.70217786934, 5587.273654424899, 5684.54523638108, 5693.28833895763, 5698.1737648041635, 5900.704964751745, 6970.407515361149, 7093.255208203168, 7115.075040244838, 7239.719488361149, 7260.491765576359, 1670.9331626734795, 1702.6169111949712, 1716.3220527891663, 1716.6995775739445, 1717.6908156531695, 1087.1140020882956, 1102.6691992402407, 1117.932924024561, 1124.0726400719439, 1135.9772804543863, 6033.245844269466, 6550.069958025147, 6569.408753212234, 6594.670266486656, 6594.9670251649395, 5992.0, 7411.62941852916, 7415.5179913305465, 7418.591977441292, 7424.034875466263, 6339.841503962438, 6571.2771595124495, 6590.637514936724, 6591.934080659132, 6612.140421745143, 3913.5695073541888, 3935.0752573145287, 3942.0933185367526, 3942.290387730236, 3950.249452603996, 7636.809079772939, 7668.424868134801, 7685.03937007874, 7704.8459030820195, 7705.267999540147, 7280.745173918887, 7615.923840761521, 7623.847523049508, 7624.08510978675, 7637.5035622684345, 7654.502457340255, 7663.31030207284, 7672.117706463828, 7674.961625192062, 7683.1548529661695, 6569.948808190667, 6852.246252912076, 7380.520266182681, 7385.187629360874, 7387.519811212254, 5794.725160464691, 7174.246704095995, 7254.657888290683, 7256.7460138894885, 7276.7089316426745, 7643.541387516767, 7646.541207527566, 7652.7704168875025, 7667.0, 7677.808054798675, 4891.828785992473, 4898.265260210855, 4901.387326584177, 4910.21436570147, 4913.975430122827, 7037.964810175917, 7094.290570942864, 7258.89111663336, 7340.082489688789, 7349.742759003623, 6982.7206911725, 7026.789196324118, 7030.261822508563, 7237.63811809418, 7247.456440766858, 5911.793087241926, 7218.819529511804, 7251.456140789356, 7254.492185546961, 7263.455240856852, 6817.8636427270185, 7043.330883566053, 7046.859062818818, 7048.718051277891, 7073.045138906387, 7240.275972402717, 7252.782416527512, 7270.655498470763, 7273.8908916365235, 7274.599897005715, 6868.862622747617, 7102.893456598052, 7113.466490013373, 7114.14630244374, 7116.715331386687], "unit": "score", "name": "prototype.html", "value": 5211.480035113598}, {"lowerIsBetter": false, "replicates": [652.5301782716444, 657.1489920552884, 683.8187880211742, 718.8418547919456, 783.2637320918336, 14490.5652830415, 14697.0, 14702.999999999987, 14707.485238016672, 14717.411303547871, 13249.337533123353, 13327.26700031498, 13340.266285354302, 13384.732305353911, 13398.717314257996, 835.5237514616671, 850.8553545897213, 851.4210336970857, 852.109545524928, 854.0434713121313, 695.1415002471944, 702.6276073680932, 847.8812966184709, 849.8470275350435, 851.0510780479782, 876.2114097312406, 885.2431171348501, 886.7738726624701, 887.3078998381241, 912.5482885971453, 714.8927660850862, 725.2674798453547, 884.0275696733606, 888.2449917570078, 906.7959709065474, 654.0026459649026, 655.9606423614598, 656.4092316914815, 656.5961933410965, 662.0169048962288, 14512.1292722437, 14563.344649490798, 14565.781513277203, 14580.70838583233, 14591.70816583673, 12499.750004999849, 12652.177608455513, 12733.808992865115, 12799.680007999781, 12804.61586152417, 10024.94987525065, 10026.574303544205, 10133.0, 10175.796484070277, 10203.183745300357, 2975.538791487323, 3473.6005359383744, 3673.430618254175, 3698.0754811297174, 3711.554613446404, 83382.58308708479, 84966.57516712439, 88087.55956220177, 88239.0, 88608.99999999936, 9610.279229057849, 9671.419714817133, 9734.451502248761, 9737.756556086155, 9746.171575416169, 21608.675869861963, 21738.565228695337, 21756.34730958074, 21763.347099587038, 21780.455488612595, 7538.585377804164, 7542.6605802739, 7609.391248700091, 7615.16233214346, 7703.075630924212, 4137.91724165521, 4138.172365526907, 4147.31386424797, 4190.434291370687, 4217.030083080908, 3482.1120614243205, 3509.473578963125, 3510.929781404409, 3517.736169787276, 3522.6125126236093, 616.4544378225303, 628.1112226199967, 629.7481007596998, 637.2766909557686, 638.1735652330243, 573.2977103048732, 594.8750762339957, 614.5851550203595, 616.9321374648785, 628.8144997225829, 8348.916510834813, 9091.908970923532, 9229.123233292827, 9455.443326579643, 9476.810463790685, 494.50302446041496, 585.2479563760547, 598.9251343582052, 599.7121381736704, 609.2158834128081, 3646.3254297954963, 3714.9628503715157, 3752.962470375316, 3973.7417067890497, 4052.0882801370044, 86190.56904715436, 87183.1281687175, 87497.0, 87575.56212219025, 87787.0, 68763.65618171878, 68895.65552172207, 69891.3010869895, 70016.0, 70925.64537177281, 57129.0, 57626.55933601609, 62541.0, 62746.0, 65299.10772274378, 7689.615519224129, 8851.40674678564, 9038.774030649287, 9102.863457048283, 9314.068593140631, 50321.245181321574, 53266.66833329198, 53962.46037539574, 56862.14706779319, 57616.71191644015, 68898.0, 70571.0, 70577.64711176412, 72213.91679124712, 73621.0, 11258.38078905668, 11519.07847372225, 11634.64698676379, 11637.476313565741, 12336.753264934472, 11997.220180688577, 12008.63974080779, 12018.0, 12035.338056406981, 12041.397930103634, 11424.257423267461, 11432.48553815097, 11434.142439316918, 11444.0, 11488.138389620979, 11490.88509114898, 11492.080633549464, 11495.31028138281, 11495.770084598094, 11537.423128843691, 11306.717332066435, 11318.943405283251, 11320.886791131983, 11324.0, 11329.263597866113, 8077.353811695168, 9236.72289831306, 9575.329726919048, 9847.113759761656, 9848.852267216142, 9900.702978910644, 9915.900840991786, 9938.900610993798, 9948.950255248677, 9966.451845148586], "unit": "score", "name": "yui.html", "value": 6834.020302357932}], "name": "dromaeo_css", "value": 7618.207118543785}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 111.0, 111.0, 112.0, 117.0, 112.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [177.0, 146.0, 146.0, 160.0, 121.0, 142.0, 141.0, 133.0, 192.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 147.7}, {"lowerIsBetter": true, "replicates": [187.0, 213.0, 267.0, 263.0, 184.0, 186.0, 184.0, 181.0, 177.0, 181.0], "unit": "score", "name": "audio-dft", "value": 202.3}, {"lowerIsBetter": true, "replicates": [76.0, 72.0, 87.0, 79.0, 57.0, 58.0, 58.0, 76.0, 78.0, 77.0], "unit": "score", "name": "audio-fft", "value": 71.8}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 128.0, 78.0, 80.0, 93.0, 108.0, 76.0, 79.0, 106.0], "unit": "score", "name": "audio-oscillator", "value": 93.6}, {"lowerIsBetter": true, "replicates": [86.0, 91.0, 85.0, 90.0, 86.0, 89.0, 85.0, 93.0, 127.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.3}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 101.0], "unit": "score", "name": "imaging-darkroom", "value": 95.2}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 84.0, 84.0, 85.0, 88.0, 84.0, 100.0, 134.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 91.4}, {"lowerIsBetter": true, "replicates": [57.0, 54.0, 54.0, 55.0, 53.0, 54.0, 55.0, 64.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.1}, {"lowerIsBetter": true, "replicates": [65.0, 63.0, 77.0, 74.0, 68.0, 66.0, 67.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [83.0, 94.0, 104.0, 83.0, 89.0, 81.0, 82.0, 82.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [132.0, 125.0, 125.0, 124.0, 136.0, 109.0, 127.0, 123.0, 128.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.9}, {"lowerIsBetter": true, "replicates": [134.0, 128.0, 142.0, 141.0, 137.0, 140.0, 139.0, 138.0, 137.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.1}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 71.0, 68.0, 67.0, 66.0, 66.0, 67.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1444.3000000000002}]} 10:08:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1444.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7618.21"}}} 10:08:29 INFO - Return code: 0 10:08:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:08:29 INFO - # TBPL SUCCESS # 10:08:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:08:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:08:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:08:29 INFO - 2016-02-10 10:08:29.964 screenresolution[1968:11418] starting screenresolution argv=screenresolution get 10:08:29 INFO - 2016-02-10 10:08:29.966 screenresolution[1968:11418] Display 0: 1600x1200x32@60 10:08:29 INFO - 2016-02-10 10:08:29.972 screenresolution[1969:11420] starting screenresolution argv=screenresolution list 10:08:29 INFO - Available Modes on Display 0 10:08:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:08:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:08:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:08:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:08:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:08:30 INFO - Intel Iris: 10:08:30 INFO - Chipset Model: Intel Iris 10:08:30 INFO - Type: GPU 10:08:30 INFO - Bus: Built-In 10:08:30 INFO - VRAM (Dynamic, Max): 1536 MB 10:08:30 INFO - Vendor: Intel (0x8086) 10:08:30 INFO - Device ID: 0x0a2e 10:08:30 INFO - Revision ID: 0x0009 10:08:30 INFO - Displays: 10:08:30 INFO - Display: 10:08:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:08:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:08:30 INFO - Display Serial Number: 1600x1200 60 10:08:30 INFO - Main Display: Yes 10:08:30 INFO - Mirror: Off 10:08:30 INFO - Online: Yes 10:08:30 INFO - Rotation: Supported 10:08:30 INFO - Return code: 0 10:08:30 INFO - Running post-action listener: _resource_record_post_action 10:08:30 INFO - Running post-run listener: _resource_record_post_run 10:08:31 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 1949696; Write bytes: 709032960; Read time: 23; Write time: 1987 10:08:31 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 392884736; Write bytes: 387109376; Read time: 29522; Write time: 659 10:08:31 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 1101824; Write bytes: 300749824; Read time: 19; Write time: 1281 10:08:31 INFO - Running post-run listener: _upload_blobber_files 10:08:31 INFO - Blob upload gear active. 10:08:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:08:31 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 10:08:31 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:08:31 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:08:31 INFO - (blobuploader) - INFO - Open directory for files ... 10:08:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:08:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:08:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:32 INFO - (blobuploader) - INFO - Done attempting. 10:08:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:08:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:08:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:33 INFO - (blobuploader) - INFO - Done attempting. 10:08:33 INFO - (blobuploader) - INFO - Iteration through files over. 10:08:33 INFO - Return code: 0 10:08:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:08:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:08:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bda235bab57dccb0511ddb14b13920558a3f435d229e3360f70716971b0e214da86173ae82da6781ceb5d8072131557a52dae0383a0053ba8800d42561897f93", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9bae0d7d8aded94b4c520976492031f9c4f6fc169347c7752d7677a5029564e97a3883d64a42609fb0bf9169af617e80de36b40872020997546596eaed171f5"} 10:08:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:08:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:08:33 INFO - Contents: 10:08:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bda235bab57dccb0511ddb14b13920558a3f435d229e3360f70716971b0e214da86173ae82da6781ceb5d8072131557a52dae0383a0053ba8800d42561897f93", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9bae0d7d8aded94b4c520976492031f9c4f6fc169347c7752d7677a5029564e97a3883d64a42609fb0bf9169af617e80de36b40872020997546596eaed171f5"} 10:08:33 INFO - Running post-run listener: copy_logs_to_upload_dir 10:08:33 INFO - Copying logs to upload dir... 10:08:33 INFO - mkdir: /builds/slave/test/build/upload/logs 10:08:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.587245 ========= master_lag: 1.51 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-02-10 10:08:35.449255) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 10:08:35.452958) ========= 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.cYANAosIDU/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.w9mN0LCuFV/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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/Firefox/sha512/bda235bab57dccb0511ddb14b13920558a3f435d229e3360f70716971b0e214da86173ae82da6781ceb5d8072131557a52dae0383a0053ba8800d42561897f93", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9bae0d7d8aded94b4c520976492031f9c4f6fc169347c7752d7677a5029564e97a3883d64a42609fb0bf9169af617e80de36b40872020997546596eaed171f5"} build_url:https://queue.taskcluster.net/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011143 build_url: 'https://queue.taskcluster.net/v1/task/dhOJVFk6QfOx-01v_-Xceg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bda235bab57dccb0511ddb14b13920558a3f435d229e3360f70716971b0e214da86173ae82da6781ceb5d8072131557a52dae0383a0053ba8800d42561897f93", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9bae0d7d8aded94b4c520976492031f9c4f6fc169347c7752d7677a5029564e97a3883d64a42609fb0bf9169af617e80de36b40872020997546596eaed171f5"}' ========= master_lag: 0.12 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 10:08:35.584545) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-02-10 10:08:35.584846) ========= 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.cYANAosIDU/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.w9mN0LCuFV/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.005140 ========= master_lag: 2.61 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-02-10 10:08:38.200832) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 10:08:38.201190) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 10:08:38.311017) ========= ========= Total master_lag: 4.42 =========