builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0041 starttime: 1456362666.34 results: success (0) buildid: 20160224030517 builduid: 32fc60eb561c4ceeb73d61602c81d277 revision: d848a5628d801a460a7244cbcdea22d328d8b310 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 17:11:06.336892) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 17:11:06.337289) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 17:11:06.337703) ========= 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.iyvGqbGBhc/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.P5Pcb3d54R/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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.005513 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 17:11:06.381926) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 17:11:06.382222) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 17:11:06.399463) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 17:11:06.399738) ========= 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.iyvGqbGBhc/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.P5Pcb3d54R/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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.005297 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 17:11:06.448579) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 17:11:06.448867) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 17:11:06.449375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 17:11:06.449923) ========= 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.iyvGqbGBhc/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.P5Pcb3d54R/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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-24 17:11:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 38.1M=0s 2016-02-24 17:11:06 (38.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161341 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 17:11:06.626673) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 17:11:06.627000) ========= 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.iyvGqbGBhc/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.P5Pcb3d54R/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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.027491 ========= master_lag: 0.39 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 17:11:07.040198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-24 17:11:07.040538) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d848a5628d801a460a7244cbcdea22d328d8b310 --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 d848a5628d801a460a7244cbcdea22d328d8b310 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iyvGqbGBhc/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.P5Pcb3d54R/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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-24 17:11:07,119 truncating revision to first 12 chars 2016-02-24 17:11:07,120 Setting DEBUG logging. 2016-02-24 17:11:07,120 attempt 1/10 2016-02-24 17:11:07,120 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d848a5628d80?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-24 17:11:08,709 unpacking tar archive at: mozilla-central-d848a5628d80/testing/mozharness/ program finished with exit code 0 elapsedTime=1.836678 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-24 17:11:08.896500) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 17:11:08.896914) ========= echo d848a5628d801a460a7244cbcdea22d328d8b310 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd848a5628d801a460a7244cbcdea22d328d8b310'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iyvGqbGBhc/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.P5Pcb3d54R/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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 d848a5628d801a460a7244cbcdea22d328d8b310 program finished with exit code 0 elapsedTime=0.005353 script_repo_revision: 'd848a5628d801a460a7244cbcdea22d328d8b310' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 17:11:08.947929) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 17:11:08.948282) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 17:11:08.961637) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-02-24 17:11:08.962032) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.iyvGqbGBhc/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.P5Pcb3d54R/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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 17:11:09 INFO - MultiFileLogger online at 20160224 17:11:09 in /builds/slave/test 17:11:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:11:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:11:09 INFO - {'append_to_log': False, 17:11:09 INFO - 'base_work_dir': '/builds/slave/test', 17:11:09 INFO - 'blob_upload_branch': 'Firefox', 17:11:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:11:09 INFO - 'branch': 'Firefox', 17:11:09 INFO - 'buildbot_json_path': 'buildprops.json', 17:11:09 INFO - 'config_files': ('talos/mac_config.py',), 17:11:09 INFO - 'default_actions': ('clobber', 17:11:09 INFO - 'read-buildbot-config', 17:11:09 INFO - 'download-and-extract', 17:11:09 INFO - 'populate-webroot', 17:11:09 INFO - 'create-virtualenv', 17:11:09 INFO - 'install', 17:11:09 INFO - 'run-tests'), 17:11:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:11:09 INFO - 'download_minidump_stackwalk': True, 17:11:09 INFO - 'download_symbols': 'ondemand', 17:11:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:11:09 INFO - 'tooltool.py': '/tools/tooltool.py', 17:11:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:11:09 INFO - '/tools/misc-python/virtualenv.py')}, 17:11:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:11:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:11:09 INFO - 'installer_path': 'installer.exe', 17:11:09 INFO - 'log_level': 'info', 17:11:09 INFO - 'log_name': 'talos', 17:11:09 INFO - 'log_to_console': True, 17:11:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:11:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:11:09 INFO - 'opt_config_files': (), 17:11:09 INFO - 'pip_index': False, 17:11:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:11:09 INFO - 'cmd': ('bash', 17:11:09 INFO - '-c', 17:11:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:11:09 INFO - 'enabled': True, 17:11:09 INFO - 'halt_on_failure': False, 17:11:09 INFO - 'name': 'check_screen_resolution'},), 17:11:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:11:09 INFO - 'cmd': ('bash', 17:11:09 INFO - '-c', 17:11:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:11:09 INFO - 'enabled': True, 17:11:09 INFO - 'halt_on_failure': False, 17:11:09 INFO - 'name': 'check_screen_resolution'},), 17:11:09 INFO - 'run_cmd_checks_enabled': True, 17:11:09 INFO - 'sps_profile': False, 17:11:09 INFO - 'sps_profile_interval': 0, 17:11:09 INFO - 'suite': 'dromaeojs-e10s', 17:11:09 INFO - 'system_bits': '32', 17:11:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:11:09 INFO - 'title': 't-yosemite-r7-0041', 17:11:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:11:09 INFO - 'use_talos_json': True, 17:11:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:11:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:11:09 INFO - 'work_dir': 'build'} 17:11:09 INFO - ##### 17:11:09 INFO - ##### Running clobber step. 17:11:09 INFO - ##### 17:11:09 INFO - Running pre-action listener: _resource_record_pre_action 17:11:09 INFO - Running main action method: clobber 17:11:09 INFO - rmtree: /builds/slave/test/build 17:11:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:11:10 INFO - Running post-action listener: _resource_record_post_action 17:11:10 INFO - ##### 17:11:10 INFO - ##### Running read-buildbot-config step. 17:11:10 INFO - ##### 17:11:10 INFO - Running pre-action listener: _resource_record_pre_action 17:11:10 INFO - Running main action method: read_buildbot_config 17:11:10 INFO - Using buildbot properties: 17:11:10 INFO - { 17:11:10 INFO - "project": "", 17:11:10 INFO - "product": "firefox", 17:11:10 INFO - "script_repo_revision": "production", 17:11:10 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 17:11:10 INFO - "repository": "", 17:11:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 17:11:10 INFO - "buildid": "20160224030517", 17:11:10 INFO - "pgo_build": "False", 17:11:10 INFO - "basedir": "/builds/slave/test", 17:11:10 INFO - "buildnumber": 120, 17:11:10 INFO - "slavename": "t-yosemite-r7-0041", 17:11:10 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 17:11:10 INFO - "platform": "yosemite_r7", 17:11:10 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:11:10 INFO - "branch": "mozilla-central", 17:11:10 INFO - "repo_path": "mozilla-central", 17:11:10 INFO - "revision": "d848a5628d801a460a7244cbcdea22d328d8b310", 17:11:10 INFO - "stage_platform": "macosx64", 17:11:10 INFO - "builduid": "32fc60eb561c4ceeb73d61602c81d277", 17:11:10 INFO - "slavebuilddir": "test" 17:11:10 INFO - } 17:11:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 17:11:10 INFO - Running post-action listener: _resource_record_post_action 17:11:10 INFO - ##### 17:11:10 INFO - ##### Running download-and-extract step. 17:11:10 INFO - ##### 17:11:10 INFO - Running pre-action listener: _resource_record_pre_action 17:11:10 INFO - Running main action method: download_and_extract 17:11:10 INFO - mkdir: /builds/slave/test/build/tests 17:11:10 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')]} 17:11:10 INFO - https://queue.taskcluster.net/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:11:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/test_packages.json 17:11:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/test_packages.json 17:11:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:11:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:11:11 INFO - Downloaded 1277 bytes. 17:11:11 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:11:11 INFO - Using the following test package requirements: 17:11:11 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:11:11 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:11:11 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 17:11:11 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:11:11 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 17:11:11 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:11:11 INFO - u'jsshell-mac.zip'], 17:11:11 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:11:11 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 17:11:11 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:11:11 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:11:11 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 17:11:11 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:11:11 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 17:11:11 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:11:11 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 17:11:11 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:11:11 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:11:11 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 17:11:11 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:11:11 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')]} 17:11:11 INFO - https://queue.taskcluster.net/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:11:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:11:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:11:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/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 17:11:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/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 17:11:12 INFO - Downloaded 17827750 bytes. 17:11:12 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'] 17:11:12 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 17:11:15 INFO - Return code: 0 17:11:15 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 17:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:15 INFO - https://queue.taskcluster.net/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:11:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:11:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:11:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/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 17:11:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/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 17:11:16 INFO - Downloaded 17827750 bytes. 17:11:16 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'] 17:11:16 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 17:11:20 INFO - Return code: 0 17:11:20 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')]} 17:11:20 INFO - https://queue.taskcluster.net/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:11:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 17:11:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 17:11:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/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 17:11:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/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 17:11:21 INFO - Downloaded 10707015 bytes. 17:11:21 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'] 17:11:21 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 17:11:21 INFO - Return code: 0 17:11:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:21 INFO - https://queue.taskcluster.net/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:11:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:11:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:11:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 17:11:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/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 17:11:24 INFO - Downloaded 111453839 bytes. 17:11:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:11:24 INFO - mkdir: /builds/slave/test/properties 17:11:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:11:24 INFO - Writing to file /builds/slave/test/properties/build_url 17:11:24 INFO - Contents: 17:11:24 INFO - build_url:https://queue.taskcluster.net/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:11:25 INFO - Running post-action listener: _resource_record_post_action 17:11:25 INFO - Running post-action listener: set_extra_try_arguments 17:11:25 INFO - ##### 17:11:25 INFO - ##### Running populate-webroot step. 17:11:25 INFO - ##### 17:11:25 INFO - Running pre-action listener: _resource_record_pre_action 17:11:25 INFO - Running main action method: populate_webroot 17:11:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:11:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:11:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:11:25 INFO - '--tppagecycles', 17:11:25 INFO - '7'], 17:11:25 INFO - 'tests': ['tsvgm']}}, 17:11:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:11:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:11:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:11:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:11:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:11:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:11:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:11:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:25 INFO - 'talos_options': ['--e10s'], 17:11:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:11:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:25 INFO - 'tests': ['damp', 'tps']}, 17:11:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:25 INFO - 'talos_options': ['--e10s'], 17:11:25 INFO - 'tests': ['damp', 'tps']}, 17:11:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:11:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:11:25 INFO - 'other': {'tests': ['a11yr', 17:11:25 INFO - 'ts_paint', 17:11:25 INFO - 'tpaint', 17:11:25 INFO - 'sessionrestore', 17:11:25 INFO - 'sessionrestore_no_auto_restore']}, 17:11:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:11:25 INFO - 'tests': ['a11yr', 17:11:25 INFO - 'ts_paint', 17:11:25 INFO - 'tpaint', 17:11:25 INFO - 'sessionrestore', 17:11:25 INFO - 'sessionrestore_no_auto_restore']}, 17:11:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:11:25 INFO - 'tests': ['a11yr', 17:11:25 INFO - 'ts_paint', 17:11:25 INFO - 'tpaint', 17:11:25 INFO - 'sessionrestore', 17:11:25 INFO - 'sessionrestore_no_auto_restore']}, 17:11:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:11:25 INFO - 'tests': ['a11yr', 17:11:25 INFO - 'ts_paint', 17:11:25 INFO - 'tpaint', 17:11:25 INFO - 'sessionrestore', 17:11:25 INFO - 'sessionrestore_no_auto_restore']}, 17:11:25 INFO - 'other_l64': {'tests': ['a11yr', 17:11:25 INFO - 'ts_paint', 17:11:25 INFO - 'tpaint', 17:11:25 INFO - 'sessionrestore', 17:11:25 INFO - 'sessionrestore_no_auto_restore']}, 17:11:25 INFO - 'other_nol64': {'tests': ['a11yr', 17:11:25 INFO - 'ts_paint', 17:11:25 INFO - 'tpaint', 17:11:25 INFO - 'sessionrestore', 17:11:25 INFO - 'sessionrestore_no_auto_restore']}, 17:11:25 INFO - 'svgr': {'tests': ['tsvgx', 17:11:25 INFO - 'tsvgr_opacity', 17:11:25 INFO - 'tart', 17:11:25 INFO - 'tscrollx', 17:11:25 INFO - 'cart']}, 17:11:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:11:25 INFO - 'tests': ['tsvgx', 17:11:25 INFO - 'tsvgr_opacity', 17:11:25 INFO - 'tart', 17:11:25 INFO - 'tscrollx', 17:11:25 INFO - 'cart']}, 17:11:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:25 INFO - 'tests': ['tp5o']}, 17:11:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:25 INFO - 'talos_options': ['--e10s'], 17:11:25 INFO - 'tests': ['tp5o']}, 17:11:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:25 INFO - 'talos_options': ['--xperf_path', 17:11:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:11:25 INFO - 'tests': ['tp5n']}, 17:11:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:25 INFO - 'talos_options': ['--e10s', 17:11:25 INFO - '--xperf_path', 17:11:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:11:25 INFO - 'tests': ['tp5n']}}, 17:11:25 INFO - 'talos.zip': {'path': '', 17:11:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:11:25 INFO - Running post-action listener: _resource_record_post_action 17:11:25 INFO - ##### 17:11:25 INFO - ##### Running create-virtualenv step. 17:11:25 INFO - ##### 17:11:25 INFO - Running pre-action listener: _resource_record_pre_action 17:11:25 INFO - Running main action method: create_virtualenv 17:11:25 INFO - Creating virtualenv /builds/slave/test/build/venv 17:11:25 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 17:11:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:11:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:11:26 INFO - Using real prefix '/tools/python27' 17:11:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:11:26 INFO - Installing distribute.............................................................................................................................................................................................done. 17:11:29 INFO - Installing pip.................done. 17:11:29 INFO - Return code: 0 17:11:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:11:29 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')]} 17:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:29 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')]} 17:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:29 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 0x10123aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18da30b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010ded30>, '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 0x100f02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010d5b20>, '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.iyvGqbGBhc/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.P5Pcb3d54R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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 17:11:29 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 17:11:29 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 17:11:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iyvGqbGBhc/Render', 17:11:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:29 INFO - 'HOME': '/Users/cltbld', 17:11:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:29 INFO - 'LOGNAME': 'cltbld', 17:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:29 INFO - 'MOZ_NO_REMOTE': '1', 17:11:29 INFO - 'NO_EM_RESTART': '1', 17:11:29 INFO - 'PAGER': '/bin/cat', 17:11:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:29 INFO - 'PWD': '/builds/slave/test', 17:11:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:29 INFO - 'SHELL': '/bin/bash', 17:11:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P5Pcb3d54R/Listeners', 17:11:29 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 17:11:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:29 INFO - 'USER': 'cltbld', 17:11:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:29 INFO - 'XPC_FLAGS': '0x0', 17:11:29 INFO - 'XPC_SERVICE_NAME': '0', 17:11:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:29 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 17:11:29 INFO - Cleaning up... 17:11:29 INFO - Return code: 0 17:11:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:11:29 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')]} 17:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:29 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')]} 17:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:29 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 0x10123aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18da30b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010ded30>, '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 0x100f02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010d5b20>, '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.iyvGqbGBhc/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.P5Pcb3d54R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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 17:11:29 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 17:11:29 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 17:11:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iyvGqbGBhc/Render', 17:11:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:29 INFO - 'HOME': '/Users/cltbld', 17:11:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:29 INFO - 'LOGNAME': 'cltbld', 17:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:29 INFO - 'MOZ_NO_REMOTE': '1', 17:11:29 INFO - 'NO_EM_RESTART': '1', 17:11:29 INFO - 'PAGER': '/bin/cat', 17:11:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:29 INFO - 'PWD': '/builds/slave/test', 17:11:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:29 INFO - 'SHELL': '/bin/bash', 17:11:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P5Pcb3d54R/Listeners', 17:11:29 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 17:11:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:29 INFO - 'USER': 'cltbld', 17:11:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:29 INFO - 'XPC_FLAGS': '0x0', 17:11:29 INFO - 'XPC_SERVICE_NAME': '0', 17:11:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:30 INFO - Downloading/unpacking psutil>=0.7.1 17:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:11:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:11:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:11:32 INFO - Installing collected packages: psutil 17:11:32 INFO - Running setup.py install for psutil 17:11:32 INFO - building 'psutil._psutil_osx' extension 17:11:32 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 17:11:33 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 17:11:33 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 17:11:33 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 17:11:33 INFO - building 'psutil._psutil_posix' extension 17:11:33 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 17:11:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:11:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:11:33 INFO - ^ 17:11:33 INFO - 1 warning generated. 17:11:33 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 17:11:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:11:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:11:33 INFO - Successfully installed psutil 17:11:33 INFO - Cleaning up... 17:11:33 INFO - Return code: 0 17:11:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:11:33 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')]} 17:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:33 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')]} 17:11:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:33 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 0x10123aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18da30b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010ded30>, '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 0x100f02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010d5b20>, '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.iyvGqbGBhc/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.P5Pcb3d54R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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 17:11:33 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 17:11:33 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 17:11:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iyvGqbGBhc/Render', 17:11:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:33 INFO - 'HOME': '/Users/cltbld', 17:11:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:33 INFO - 'LOGNAME': 'cltbld', 17:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:33 INFO - 'MOZ_NO_REMOTE': '1', 17:11:33 INFO - 'NO_EM_RESTART': '1', 17:11:33 INFO - 'PAGER': '/bin/cat', 17:11:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:33 INFO - 'PWD': '/builds/slave/test', 17:11:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:33 INFO - 'SHELL': '/bin/bash', 17:11:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P5Pcb3d54R/Listeners', 17:11:33 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 17:11:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:33 INFO - 'USER': 'cltbld', 17:11:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:33 INFO - 'XPC_FLAGS': '0x0', 17:11:33 INFO - 'XPC_SERVICE_NAME': '0', 17:11:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:11:34 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 17:11:34 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 17:11:34 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 17:11:34 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 17:11:34 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 17:11:34 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 17:11:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:11:36 INFO - Installing collected packages: mozsystemmonitor 17:11:36 INFO - Running setup.py install for mozsystemmonitor 17:11:36 INFO - Successfully installed mozsystemmonitor 17:11:36 INFO - Cleaning up... 17:11:36 INFO - Return code: 0 17:11:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:11:36 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')]} 17:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:36 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')]} 17:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:36 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 0x10123aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18da30b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010ded30>, '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 0x100f02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010d5b20>, '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.iyvGqbGBhc/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.P5Pcb3d54R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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 17:11:36 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 17:11:36 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 17:11:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iyvGqbGBhc/Render', 17:11:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:36 INFO - 'HOME': '/Users/cltbld', 17:11:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:36 INFO - 'LOGNAME': 'cltbld', 17:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:36 INFO - 'MOZ_NO_REMOTE': '1', 17:11:36 INFO - 'NO_EM_RESTART': '1', 17:11:36 INFO - 'PAGER': '/bin/cat', 17:11:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:36 INFO - 'PWD': '/builds/slave/test', 17:11:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:36 INFO - 'SHELL': '/bin/bash', 17:11:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P5Pcb3d54R/Listeners', 17:11:36 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 17:11:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:36 INFO - 'USER': 'cltbld', 17:11:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:36 INFO - 'XPC_FLAGS': '0x0', 17:11:36 INFO - 'XPC_SERVICE_NAME': '0', 17:11:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:36 INFO - Downloading/unpacking blobuploader==1.2.4 17:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:39 INFO - Downloading blobuploader-1.2.4.tar.gz 17:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:11:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:11:39 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 17:11:39 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 17:11:39 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 17:11:39 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 17:11:39 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 17:11:39 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 17:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:11:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:11:40 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 17:11:40 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 17:11:40 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 17:11:40 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 17:11:40 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 17:11:40 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 17:11:40 INFO - Downloading docopt-0.6.1.tar.gz 17:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:11:40 INFO - Installing collected packages: blobuploader, requests, docopt 17:11:40 INFO - Running setup.py install for blobuploader 17:11:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:11:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:11:40 INFO - Running setup.py install for requests 17:11:41 INFO - Running setup.py install for docopt 17:11:41 INFO - Successfully installed blobuploader requests docopt 17:11:41 INFO - Cleaning up... 17:11:41 INFO - Return code: 0 17:11:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:11:41 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')]} 17:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:41 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')]} 17:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:41 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 0x10123aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18da30b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010ded30>, '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 0x100f02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010d5b20>, '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.iyvGqbGBhc/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.P5Pcb3d54R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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 17:11:41 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 17:11:41 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 17:11:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iyvGqbGBhc/Render', 17:11:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:41 INFO - 'HOME': '/Users/cltbld', 17:11:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:41 INFO - 'LOGNAME': 'cltbld', 17:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:41 INFO - 'MOZ_NO_REMOTE': '1', 17:11:41 INFO - 'NO_EM_RESTART': '1', 17:11:41 INFO - 'PAGER': '/bin/cat', 17:11:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:41 INFO - 'PWD': '/builds/slave/test', 17:11:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:41 INFO - 'SHELL': '/bin/bash', 17:11:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P5Pcb3d54R/Listeners', 17:11:41 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 17:11:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:41 INFO - 'USER': 'cltbld', 17:11:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:41 INFO - 'XPC_FLAGS': '0x0', 17:11:41 INFO - 'XPC_SERVICE_NAME': '0', 17:11:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:11:41 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-u311wX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:11:41 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-QF9QJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:11:41 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-Ej6Vca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:11:42 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-OgXI6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:11:42 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-Sm_QeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:11:42 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-fDCqdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:11:42 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-NII1Gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:11:42 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-tMZmFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:11:42 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-0Cgqp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:11:42 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-werYjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:11:42 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-qo1Hlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:11:42 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-IIUTmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:11:43 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-Y78zXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:11:43 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-dKXthp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:43 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-CQSooK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:11:43 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-hCFhrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:11:43 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-H9pe7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:11:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:11:43 INFO - Running setup.py install for manifestparser 17:11:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:11:43 INFO - Running setup.py install for mozcrash 17:11:43 INFO - Running setup.py install for mozdebug 17:11:43 INFO - Running setup.py install for mozdevice 17:11:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:11:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:11:44 INFO - Running setup.py install for mozfile 17:11:44 INFO - Running setup.py install for mozhttpd 17:11:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:11:44 INFO - Running setup.py install for mozinfo 17:11:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:11:44 INFO - Running setup.py install for mozInstall 17:11:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:11:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:11:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:11:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:11:44 INFO - Running setup.py install for mozleak 17:11:44 INFO - Running setup.py install for mozlog 17:11:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:11:45 INFO - Running setup.py install for moznetwork 17:11:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:11:45 INFO - Running setup.py install for mozprocess 17:11:45 INFO - Running setup.py install for mozprofile 17:11:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:11:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:11:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:11:45 INFO - Running setup.py install for mozrunner 17:11:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:11:45 INFO - Running setup.py install for mozscreenshot 17:11:45 INFO - Running setup.py install for moztest 17:11:45 INFO - Running setup.py install for mozversion 17:11:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:11:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:11:46 INFO - Cleaning up... 17:11:46 INFO - Return code: 0 17:11:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:46 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 0x10123aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18da30b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010ded30>, '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 0x100f02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010d5b20>, '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.iyvGqbGBhc/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.P5Pcb3d54R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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 17:11:46 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 17:11:46 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 17:11:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iyvGqbGBhc/Render', 17:11:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:46 INFO - 'HOME': '/Users/cltbld', 17:11:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:46 INFO - 'LOGNAME': 'cltbld', 17:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:46 INFO - 'MOZ_NO_REMOTE': '1', 17:11:46 INFO - 'NO_EM_RESTART': '1', 17:11:46 INFO - 'PAGER': '/bin/cat', 17:11:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:46 INFO - 'PWD': '/builds/slave/test', 17:11:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:46 INFO - 'SHELL': '/bin/bash', 17:11:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P5Pcb3d54R/Listeners', 17:11:46 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 17:11:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:46 INFO - 'USER': 'cltbld', 17:11:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:46 INFO - 'XPC_FLAGS': '0x0', 17:11:46 INFO - 'XPC_SERVICE_NAME': '0', 17:11:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:11:46 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-WoV40c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:11:46 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)) 17:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:11:46 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-ULWtNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:11:46 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)) 17:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:11:46 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-DcDE8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:11:46 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)) 17:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:11:46 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-8BG6Xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:11:46 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)) 17:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:11:46 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-CdI4UQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:11:46 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)) 17:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:11:46 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-oFOobY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:11:47 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)) 17:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:11:47 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-ieJWX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:11:47 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)) 17:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:11:47 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-B1I06B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:11:47 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)) 17:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:11:47 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-6NbBJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:11:47 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)) 17:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:11:47 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-BurxDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:11:47 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)) 17:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:11:47 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-MkRPlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:11:47 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)) 17:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:11:47 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-Trno62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:11:47 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)) 17:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:11:47 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-A_p0LU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:11:47 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)) 17:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:11:47 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-ReDWuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:11:47 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)) 17:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:47 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-FCtdt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:47 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)) 17:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:11:47 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-b61Rry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:11:48 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)) 17:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:11:48 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-0Wynzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:11:48 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)) 17:11:48 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)) 17:11:48 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)) 17:11:48 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)) 17:11:48 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)) 17:11:48 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)) 17:11:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:50 INFO - Downloading blessings-1.6.tar.gz 17:11:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:11:51 INFO - Installing collected packages: blessings 17:11:51 INFO - Running setup.py install for blessings 17:11:51 INFO - Successfully installed blessings 17:11:51 INFO - Cleaning up... 17:11:51 INFO - Return code: 0 17:11:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:11:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:11:51 INFO - Reading from file tmpfile_stdout 17:11:51 INFO - Current package versions: 17:11:51 INFO - blessings == 1.6 17:11:51 INFO - blobuploader == 1.2.4 17:11:51 INFO - docopt == 0.6.1 17:11:51 INFO - manifestparser == 1.1 17:11:51 INFO - mozInstall == 1.12 17:11:51 INFO - mozcrash == 0.16 17:11:51 INFO - mozdebug == 0.1 17:11:51 INFO - mozdevice == 0.48 17:11:51 INFO - mozfile == 1.2 17:11:51 INFO - mozhttpd == 0.7 17:11:51 INFO - mozinfo == 0.9 17:11:51 INFO - mozleak == 0.1 17:11:51 INFO - mozlog == 3.1 17:11:51 INFO - moznetwork == 0.27 17:11:51 INFO - mozprocess == 0.22 17:11:51 INFO - mozprofile == 0.28 17:11:51 INFO - mozrunner == 6.11 17:11:51 INFO - mozscreenshot == 0.1 17:11:51 INFO - mozsystemmonitor == 0.0 17:11:51 INFO - moztest == 0.7 17:11:51 INFO - mozversion == 1.4 17:11:51 INFO - psutil == 3.1.1 17:11:51 INFO - requests == 1.2.3 17:11:51 INFO - wsgiref == 0.1.2 17:11:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:11: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')]} 17:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11: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')]} 17:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:51 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 0x10123aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18da30b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010ded30>, '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 0x100f02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010d5b20>, '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.iyvGqbGBhc/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.P5Pcb3d54R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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 17:11:51 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 17:11:51 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 17:11:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iyvGqbGBhc/Render', 17:11:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:51 INFO - 'HOME': '/Users/cltbld', 17:11:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:51 INFO - 'LOGNAME': 'cltbld', 17:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:51 INFO - 'MOZ_NO_REMOTE': '1', 17:11:51 INFO - 'NO_EM_RESTART': '1', 17:11:51 INFO - 'PAGER': '/bin/cat', 17:11:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:51 INFO - 'PWD': '/builds/slave/test', 17:11:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:51 INFO - 'SHELL': '/bin/bash', 17:11:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P5Pcb3d54R/Listeners', 17:11:51 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 17:11:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:51 INFO - 'USER': 'cltbld', 17:11:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:51 INFO - 'XPC_FLAGS': '0x0', 17:11:51 INFO - 'XPC_SERVICE_NAME': '0', 17:11:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:52 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)) 17:11:52 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)) 17:11:52 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)) 17:11:52 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)) 17:11:52 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)) 17:11:52 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)) 17:11:52 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)) 17:11:52 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)) 17:11:52 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)) 17:11:52 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)) 17:11:52 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)) 17:11:52 INFO - Cleaning up... 17:11:52 INFO - Return code: 0 17:11:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:11:52 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')]} 17:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:52 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')]} 17:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:52 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 0x10123aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18da30b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010ded30>, '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 0x100f02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010d5b20>, '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.iyvGqbGBhc/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.P5Pcb3d54R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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 17:11:52 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 17:11:52 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 17:11:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iyvGqbGBhc/Render', 17:11:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:52 INFO - 'HOME': '/Users/cltbld', 17:11:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:52 INFO - 'LOGNAME': 'cltbld', 17:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:52 INFO - 'MOZ_NO_REMOTE': '1', 17:11:52 INFO - 'NO_EM_RESTART': '1', 17:11:52 INFO - 'PAGER': '/bin/cat', 17:11:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:52 INFO - 'PWD': '/builds/slave/test', 17:11:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:52 INFO - 'SHELL': '/bin/bash', 17:11:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P5Pcb3d54R/Listeners', 17:11:52 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 17:11:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:52 INFO - 'USER': 'cltbld', 17:11:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:52 INFO - 'XPC_FLAGS': '0x0', 17:11:52 INFO - 'XPC_SERVICE_NAME': '0', 17:11:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:52 INFO - Downloading/unpacking jsonschema 17:11: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 17:11: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 17:11: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 17:11: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 17:11: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 17:11: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 17:11:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:11:54 INFO - Downloading/unpacking functools32 (from jsonschema) 17:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:55 INFO - Downloading functools32-3.2.3-2.tar.gz 17:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:11:55 INFO - warning: no files found matching '*.txt' 17:11:55 INFO - no previously-included directories found matching 'build' 17:11:55 INFO - no previously-included directories found matching 'dist' 17:11:55 INFO - no previously-included directories found matching '.git*' 17:11:55 INFO - Installing collected packages: jsonschema, functools32 17:11:55 INFO - Running setup.py install for functools32 17:11:55 INFO - warning: no files found matching '*.txt' 17:11:55 INFO - no previously-included directories found matching 'build' 17:11:55 INFO - no previously-included directories found matching 'dist' 17:11:55 INFO - no previously-included directories found matching '.git*' 17:11:55 INFO - Successfully installed jsonschema functools32 17:11:55 INFO - Cleaning up... 17:11:55 INFO - Return code: 0 17:11:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:11: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')]} 17:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11: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')]} 17:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10123aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18da30b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010ded30>, '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 0x100f02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010d5b20>, '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.iyvGqbGBhc/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.P5Pcb3d54R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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 17:11: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', 'flake8'] in /builds/slave/test/build 17:11: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 flake8 17:11:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iyvGqbGBhc/Render', 17:11:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:55 INFO - 'HOME': '/Users/cltbld', 17:11:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:55 INFO - 'LOGNAME': 'cltbld', 17:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:55 INFO - 'MOZ_NO_REMOTE': '1', 17:11:55 INFO - 'NO_EM_RESTART': '1', 17:11:55 INFO - 'PAGER': '/bin/cat', 17:11:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:55 INFO - 'PWD': '/builds/slave/test', 17:11:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:55 INFO - 'SHELL': '/bin/bash', 17:11:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P5Pcb3d54R/Listeners', 17:11:55 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 17:11:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:55 INFO - 'USER': 'cltbld', 17:11:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:55 INFO - 'XPC_FLAGS': '0x0', 17:11:55 INFO - 'XPC_SERVICE_NAME': '0', 17:11:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:55 INFO - Downloading/unpacking flake8 17:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:11:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:11: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 17:11: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 17:11: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 17:11: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 17:11: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 17:11: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 17:11:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:11:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:11: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 17:11: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 17:11: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 17:11: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 17:11: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 17:11: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 17:11:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:11: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 17:11: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 17:11: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 17:11: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 17:11: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 17:11: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 17:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:11:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:11:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:11:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:11:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:11:59 INFO - no previously-included directories found matching 'docs/_build' 17:11:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:11:59 INFO - Running setup.py install for pep8 17:11:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:11:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:11:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:11:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:11:59 INFO - no previously-included directories found matching 'docs/_build' 17:11:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:11:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:11:59 INFO - Cleaning up... 17:11:59 INFO - Return code: 0 17:11:59 INFO - Running post-action listener: _resource_record_post_action 17:11:59 INFO - Running post-action listener: _start_resource_monitoring 17:11:59 INFO - Starting resource monitoring. 17:11:59 INFO - ##### 17:11:59 INFO - ##### Running install step. 17:11:59 INFO - ##### 17:11:59 INFO - Running pre-action listener: _resource_record_pre_action 17:11:59 INFO - Running main action method: install 17:11:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:12:00 INFO - Reading from file tmpfile_stdout 17:12:00 INFO - Detecting whether we're running mozinstall >=1.0... 17:12:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:12:00 INFO - Reading from file tmpfile_stdout 17:12:00 INFO - Output received: 17:12:00 INFO - Usage: mozinstall [options] installer 17:12:00 INFO - Options: 17:12:00 INFO - -h, --help show this help message and exit 17:12:00 INFO - -d DEST, --destination=DEST 17:12:00 INFO - Directory to install application into. [default: 17:12:00 INFO - "/builds/slave/test"] 17:12:00 INFO - --app=APP Application being installed. [default: firefox] 17:12:00 INFO - mkdir: /builds/slave/test/build/application 17:12:00 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'] 17:12:00 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 17:12:34 INFO - Reading from file tmpfile_stdout 17:12:34 INFO - Output received: 17:12:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:12:34 INFO - Running post-action listener: _resource_record_post_action 17:12:34 INFO - ##### 17:12:34 INFO - ##### Running run-tests step. 17:12:34 INFO - ##### 17:12:34 INFO - Running pre-action listener: _resource_record_pre_action 17:12:34 INFO - Running main action method: run_tests 17:12:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:12:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:12:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:12:34 INFO - 2016-02-24 17:12:34.546 screenresolution[1654:7551] starting screenresolution argv=screenresolution get 17:12:34 INFO - 2016-02-24 17:12:34.549 screenresolution[1654:7551] Display 0: 1600x1200x32@60 17:12:34 INFO - 2016-02-24 17:12:34.554 screenresolution[1655:7553] starting screenresolution argv=screenresolution list 17:12:34 INFO - Available Modes on Display 0 17:12:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:12:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:12:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:12:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:12:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:12:34 INFO - Intel Iris: 17:12:34 INFO - Chipset Model: Intel Iris 17:12:34 INFO - Type: GPU 17:12:34 INFO - Bus: Built-In 17:12:34 INFO - VRAM (Dynamic, Max): 1536 MB 17:12:34 INFO - Vendor: Intel (0x8086) 17:12:34 INFO - Device ID: 0x0a2e 17:12:34 INFO - Revision ID: 0x0009 17:12:34 INFO - Displays: 17:12:34 INFO - Display: 17:12:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:12:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:12:34 INFO - Display Serial Number: 1600x1200 60 17:12:34 INFO - Main Display: Yes 17:12:34 INFO - Mirror: Off 17:12:34 INFO - Online: Yes 17:12:34 INFO - Rotation: Supported 17:12:34 INFO - Return code: 0 17:12:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:12:34 INFO - Python 2.7.3 17:12:34 INFO - Return code: 0 17:12:34 INFO - grabbing minidump binary from tooltool 17:12:34 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')]} 17:12:34 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 0x1010ded30>, '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 0x100f02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010d5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:12:34 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 17:12:34 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 17:12:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:12:34 INFO - Return code: 0 17:12:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:12:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:12:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:12:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:12:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:12:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:12:36 INFO - Return code: 0 17:12:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:12:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iyvGqbGBhc/Render', 17:12:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:12:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:12:36 INFO - 'HOME': '/Users/cltbld', 17:12:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:12:36 INFO - 'LOGNAME': 'cltbld', 17:12:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:12:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:36 INFO - 'MOZ_NO_REMOTE': '1', 17:12:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:12:36 INFO - 'NO_EM_RESTART': '1', 17:12:36 INFO - 'PAGER': '/bin/cat', 17:12:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:36 INFO - 'PWD': '/builds/slave/test', 17:12:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:12:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:12:36 INFO - 'SHELL': '/bin/bash', 17:12:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P5Pcb3d54R/Listeners', 17:12:36 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 17:12:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:12:36 INFO - 'USER': 'cltbld', 17:12:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:12:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:36 INFO - 'XPC_FLAGS': '0x0', 17:12:36 INFO - 'XPC_SERVICE_NAME': '0', 17:12:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:12:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:12:36 INFO - mozversion application_buildid: 20160224030517 17:12:36 INFO - mozversion application_changeset: d848a5628d801a460a7244cbcdea22d328d8b310 17:12:36 INFO - mozversion application_display_name: Nightly 17:12:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:12:36 INFO - mozversion application_name: Firefox 17:12:36 INFO - mozversion application_remotingname: firefox 17:12:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:12:36 INFO - mozversion application_vendor: Mozilla 17:12:36 INFO - mozversion application_version: 47.0a1 17:12:36 INFO - mozversion platform_buildid: 20160224030517 17:12:36 INFO - mozversion platform_changeset: d848a5628d801a460a7244cbcdea22d328d8b310 17:12:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:12:36 INFO - mozversion platform_version: 47.0a1 17:12:36 INFO - using testdate: 1456362756 17:12:36 INFO - actual date: 1456362756 17:12:36 INFO - starting webserver on 'localhost:49279' 17:12:36 INFO - SUITE-START | Running 2 tests 17:12:36 INFO - TEST-START | dromaeo_css 17:12:36 INFO - operating with platform_type : mac_ 17:12:36 INFO - Initialising browser for dromaeo_css test... 17:12:36 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/tmpU3iC55/profile http://localhost:49279/getInfo.html) 17:12:39 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 17:12:39 INFO - PROCESS | 1676 | colorDepth:24 17:12:39 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 17:12:39 INFO - PROCESS | 1676 | __metrics 17:12:40 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 17:12:40 INFO - TEST-INFO | 1676: exit 0 17:12:40 INFO - Browser initialized. 17:12:40 INFO - Running cycle 1/1 for dromaeo_css test... 17:12:40 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/tmpU3iC55/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:12:52 INFO - PROCESS | 1680 | RSS: Main: 256221184 17:12:52 INFO - PROCESS | 1680 | 17:13:42 INFO - PROCESS | 1680 | 1456362822614 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] 17:15:53 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 17:15:54 INFO - PROCESS | 1680 | RSS: Main: 269541376 17:15:54 INFO - PROCESS | 1680 | 17:18:56 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 17:18:56 INFO - PROCESS | 1680 | RSS: Main: 281337856 17:18:56 INFO - PROCESS | 1680 | 17:21:58 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 17:21:59 INFO - PROCESS | 1680 | RSS: Main: 282726400 17:21:59 INFO - PROCESS | 1680 | 17:25:01 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 17:25:01 INFO - PROCESS | 1680 | RSS: Main: 283893760 17:25:01 INFO - PROCESS | 1680 | 17:28:04 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 17:28:04 INFO - PROCESS | 1680 | RSS: Main: 288407552 17:28:04 INFO - PROCESS | 1680 | 17:31:07 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 17:31:07 INFO - PROCESS | 1680 | RSS: Main: 289660928 17:31:07 INFO - PROCESS | 1680 | 17:31:07 INFO - PROCESS | 1680 | __start_tp_report 17:31:07 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 17:31:07 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 17:31:07 INFO - PROCESS | 1680 | |i|pagename|runs| 17:31:07 INFO - PROCESS | 1680 | |0;dojo.html;3529.364714351417;3576.1059735066233;3577.177249232675;3604.6395360463957;3610.747247692662;5768.798092066773;5795.101759227316;5805.680687562182;5807.274090738658;5808.59339846211;5640.492355687988;5667.5749318801045;5716.456936591027;5772.769089236425;5833.854153646161;5089.389273287202;5132.923006154911;5153.304303918961;5179.378474583055;5181.041507321139;5242.711650859202;5259.0796610593;5265.842024739245;5295.391030031557;5308.681479111266;5033.622478314122;5081.542661160494;5167.819126330561;5178.844634660966;5224.947750522484;5184.144616138333;5198.584113270929;5203.19350500673;5222.216667499867;5271.472852714736;5046.873828154289;5161.870953226162;5174.689518628894;5176.637635365526;5224.8693782655355;4862.270659401082;5043.8903441242865;5619.831405057855;5640.153976903456;5711.000574899376;6272.686365681698;6274.435300822902;6281.466075383598;6283.717232724538;6296.527760417941;6168.043953187218;6201.224846894138;6247.375262473762;6252.843678908018;6283.151774510428;5907.14346419771;5916.437938395846;5936.8218953430605;5944.524438044946;5974.074018527135;6229.127922090911;6323.114763933053;6324.525660575383;6334.968325158345;6342.112104305401;5204.375474943031;6124.136831511551;6240.65676387794;6243.531735119885;6245;5882.911756323659;6159.952808022647;6212.409821067082;6282.528810339243;6336.904946425807;6091.42131497507;6183.9565381783195;6195.96902015487;6236.594621349688;6270.2789179244055;6291.213598300213;6293.465055470337;6297.716602752887;6303.054541818764;6316.621002739758;4704.059188162381;4919.4834542373255;4929.433115191727;4953.752312384367;4953.801847926043;3303.768736188492;3834.9808250959127;3921.7058370737586;4383.824647014148;4457.840961350007;5758.712064396764;5766.250387449689;5768.798092066758;5780.132980053026;5780.132980053026;6141.692915354214;6252.749890004349;6268.1851359323;6275.623462592259;6281.685915704196;4759.357486739315;4845.685030473008;5774.480296773227;5783.797567085132;5836.7957121501395;5410.404855465896;5452.618316717871;5460.453954604587;5461.2354270402175;5467.863303417446;6226.034964580497;6314.021326694462;6407.615543067338;6408.391202835724;6412.454941330039;6197.628142311476;6235.719392627433;6246.656433896179;6254.312025677263;6260.342664020212;6362.204724409449;6368.044793281045;6374.139491168633;6385.329540398191;6393.680315984275;6098.522998456991;6148.385161483816;6247.2815626201755;6256.687165641609;6267.686615669107;5115.514026167508;5504.834854954358;6192.102145188832;6242;6282.151909492343;5954.166416701752;6025.698715064317;6213.813585592258;6217.222847144107;6218.9116904542425;5850.64896106235;6181.072839074175;6200.286966998672;6203.875922481616;6210.285817131088;6052.364501727256;6054.515638748801;6064.211652485149;6091.360407157184;6155.815325540241;5394.946050539601;5886.882262354643;6088.178095957166;6134.283518479682;6204.72078756448;6050.969745151246;6052.425019623129;6053.697315134314;6055.091736239599;6059.121427393092 17:31:07 INFO - PROCESS | 1680 | |1;ext.html;426.7738098807633;449.9707519011266;484.1164874104759;558.9240711630113;594.1829983772313;36149.81925090374;36701.26597468049;36726.63273367265;36840.631593684055;36893.99999999996;37158.44262336061;37645.24709505808;37713.24573508535;37716.81141594288;37724.811375943085;9344.112309330603;9573.234141268682;9609.951950240238;9617.990111038345;9651.372660777028;9427.010163932791;9531.80936381272;9551.761205969871;9567.904320956772;9599.520023998806;9527.761805954837;9559.044095590454;9589.616415343378;9606.327557071008;9634.277429192838;9494.335396522247;9571.330006899554;9575.760605984837;9596;9598.520073996307;9433.575489103006;9526.85709714355;9599.32804703671;9606.567704453317;9613.567389467491;36973.26053478942;37012.81493592515;37279.06802329936;37415.812920935496;37495;2730.754232119119;3135.764817638686;3202.247471844115;3336.6496517865517;3378.290558982592;21621;25729.742702572923;26263.474730505473;26583.335416614547;26727;2809.5364264896266;2819.6898341182455;2860.7425331720247;2873.482773100841;2967;274599;329099.35450322833;330583;332460;333021;43297.268109275275;43850.561494385285;43861;43872.3419148713;43875;42777.35833962493;42908.92727681833;42926;43081.569184308384;43217.56782432198;14948.402063917321;15013.774793378108;15027.248637568078;15048.398064077533;15131.848681513044;12066.75866482683;12168.391580420943;12172.695682607828;12321.753564928651;12490.313032783102;13739.313034348243;13743;13882.51411200603;13988.72022559543;14321.35553900077;5233.502817232356;6101.267847858286;6147.477464415575;6218.533609979269;6238.532110091761;978.6036655154531;978.6819283732815;1044.3107549017764;1094.3503416107212;1153.1234972460845;24923.003079876966;29320.560191596716;29340.85329573381;29473.968411105507;29822.807087716683;872.8559787635096;1063.0751246415668;1088.5972190289644;1140.509580880213;1214.4595654933646;13737.793933091012;13890.09714368583;13920.930395348161;14921.3285402155;15021.920014315;597691;601823;605432;609566;612976;57136.14295785566;57574.424255757745;57662.13506797401;58316;58369.70815145897;1448.2034880815509;1457.5263039512201;1459.9708005840037;1460.5107289058285;1594.5296137639425;22725.545489089796;28534.286642834097;29872.850635746683;30254.697453025186;30437;50706.492935071656;50714.73213169553;50727.492725072276;51252.74373628108;51258;463753.6812316052;470335;472419;473678;474120;32833.671663283065;43267;43664.56335436732;44143.55856441394;44145.77927110472;42437.22872369556;43028.139437210455;43869;43912.121757565306;44771.77614111909;31385.37229255448;34586.82706586451;35992.820035899655;36312.818435907655;36356;35792.64207357893;36123;36203.456948146326;36310.63689363178;36349.818250908575;31674;35820;35936.10159746027;36307.45538816973;36898;24284.392890177885;29748.81004759872;30412.5438118424;30455.695443045286;30472.390552189274;18675.346362877233;25164.874175629004;25298.747012530377;25471.36321591975;25658.358541036625 17:31:07 INFO - PROCESS | 1680 | |2;jquery.html;357.383513439317;361.2684314263616;361.5570925616121;365.70377993825;368.5154022460463;14665.92667036666;18506.629867402677;18623.348182813603;18708.625827483458;19318.806811931878;18476.907615461936;18843.43469695908;18865.811341886576;18969.430917072474;19177.42467725967;5407.972960135194;5488.862778430551;5648.068068768669;5694.345150307726;5733.913991290134;5534.667919924797;5550.16747487878;5611.270534830466;5623.156526521014;5647.689377084259;5411.404745478014;5580.581456390767;5605.691686957216;5612.635178713391;5637.098064309711;5503.587230957694;5542.418046105182;5567.47109024642;5573.024720673886;5589.413111623282;5277.6041796865;5345.919811202835;5372.489613486712;5380.811671591515;5383.784648614051;9935.254855885838;12187.878121218762;12719.618411447671;18098.27606895736;23671.526569468686;1743.111013383171;1994.9700754488695;2158.4280165756086;2394.341556072077;2548.324693956103;9667.27495437838;11017.944910275477;13806.895448364106;14149.858501414958;14832.925835370863;1470.8235011798545;1828.5245836082581;1857.6099019205983;1886.8018858019984;1964.8919309437974;83171.16828831755;95159.57260641096;105153.47423262912;108749;110262;11163.553457861595;11171.553137874556;11283.605073822377;11290.153238507144;11396.430178491042;12096.697582560506;12649.747005060031;13236.536721214712;13442;13443.193408395331;8088.150744171778;8183.590820458953;8317.95841020791;8329.750107496784;8363.916360836436;8376.958115209385;8377.37169712274;8460.576971151419;8536.359773017048;8547.487150770974;3804.2581696568905;4022.0749227677798;4371.9944412785235;4418.712783669115;4443.600075993176;1871.606962537855;1895.2987394663787;1920.19351872214;1922.3079691311116;1941.2914286285404;885.1590988560893;892.2638822971074;929.3958926697701;982.7051884434641;1068.4497483795851;17905.28378864857;19048.85706857593;19356.70964935527;19442;19746.605067898563;925.3013974449382;946.3612061858219;971.8153550825461;975.6633961283346;984.2618036472645;8345.66617335312;10622.521986510626;10652.414117223627;10674.78650426987;10706.46467676613;595041;600708;615174;635200;644979;119491;119701.40149299198;120180;120541;121706;1013.7769690668041;1014.6905193915779;1016.8779746430475;1029.9021592948807;1038.6312858934969;17613.943163410237;17926.731099033786;18062.006589637695;18526.351577694717;18527.0736463179;41005.79497102495;50279;52589.94820103653;53172.40482785523;56179;73098;73251.63374183096;73296.26703733108;74433.62783186049;74785;6612.437942774918;7840.0199975003125;7985.72049978248;8088.018435483109;8159.714409995621;9399.389039712396;12386.442610082388;13387.531436399679;13472.86527134716;13564.93217533906;10357.22320825926;10788.244822862323;11169.162312826733;11259.831102533632;11437.828432573684;10165.203229356985;10280.07479326864;10289.9485502572;10969.23215374948;11006.614768483065;11365.829512557153;11541.422928853355;11774.411279435823;11850.407479625812;11872.881271187178;8009.8398032040195;8060.637271322687;8073;8085.39359548048;8115.513069215866;9093.818123637358;11603.477843497232;11603.535858565563;11619.883801161881;11623.07015438746 17:31:07 INFO - PROCESS | 1680 | |3;mootools.html;1515.3559737111727;1522.2388805597202;1756.5959829239275;1891.527118220445;1906.428071578526;6597;6792.592444453337;8617.91382086179;8705.303575713944;8740.300775937918;8515.531645759496;8535.829283414329;8657.95671021644;8662.566871656407;8681.305495560357;2418.17781954136;2442.6091825307954;2445;2457.0294733580226;2463.4087818923417;2419.458667168452;2501.6247562865533;2517.0435234610914;2517.0938462153704;2529.4182338062255;2140.9464763380884;2370.668106465096;2378.762123787616;2391.820613453989;2476.5170791695627;2412.7949124324455;2439.621858611918;2445.5231229910173;2445.8410203336903;2451.3013791069548;2094.759102703178;2401.8318717689767;2430.283066495388;2433.9391515212083;2434.5982912819363;8509.914900851036;8563.229309362125;8563.44337618059;8588.141185881424;8604.52675102869;5287.762050707689;5382.569394448435;5422.566194704415;5431.429699881534;5488.56091512682;3535.876244331436;3580.6598373154507;3642.8360723767496;3646.3801153803915;3663.084228942764;1056.2025670618634;1078.8759292681284;1080.1089101491302;1086.315621158665;1090.907272881806;11652.76694466106;11687.883121168765;11793.879581439835;11851.288922664668;11857.940710296394;4307.246231909403;4615.884602884955;4845.9030819383415;4891.217405215149;4935.975320123448;10139.2902496826;10146.239032072624;10201.38791672502;10203.642872499428;10235.948820256;5442.319710036246;5457.727113644302;5468.316460442445;5487.64330318528;5490.945090549123;4918.139325618003;4931.679440836334;4959.479254678279;4967.304577359173;4974.975125124423;3817.5800661927165;3837.136644255076;3838.347480928249;3889.124946886984;3898;1268.6447794617523;1278.619091381306;1280.1231156657534;1280.2638482872198;1302.2316833068535;1024.1397226329918;1113.8050841102774;1126.2679258482053;1132.8300754886832;1341.336038660869;6097.87189369968;6620.404163625297;6952.130983627047;7810;7954.522728636301;524.5777149394773;609.7987664070846;629.6159342800888;636.0840389838618;752.6537792615349;4931.309616653672;5507.7246137692955;5767.932932407434;5859.53123750099;6103.450689437972;8867.600957956907;10182.592696292213;10486.26596138263;10573.043986862454;10578.994995475417;10133.08802207805;10535.63125290611;10552;10615.575376984989;10650.627228046982;8021.438499304993;8078.515289082674;8174.3051840593025;8191.426600138052;8204.425690201748;7744.883826742716;7846.60766961661;7865.84268314619;7891.487053341514;7925.484843485155;9095.727128186165;9201.355905086579;9275.86086208694;9310.860337095084;9434.811303774024;9470.05299470075;9650;9682.177014953808;9804.85292720624;9878.85181722289;7845.254700803414;8101.230383113595;8122.878156827534;8164.959175204086;8171.264586187272;8091.595420228848;8149.266566009088;8160.795980100545;8204.958975205085;8222.054463736747;6088.269407671108;6529.347065293433;7266.309700578437;7357.301056399633;7369.263073692802;6957.8956315654295;6990.545614535039;7011.228764835762;7106.395956343768;7120.679569419285;7469.887951680837;7476.439267054884;7478.177400486051;7481.812954676177;7560.773176804704;6663.966680166568;6696.7656132035145;6710.429613482908;6744;6770.1537307836525;6777.254502004874;6899.206591242071;6922.5154239202775;6924.030635710904;6931.445484361138 17:31:07 INFO - PROCESS | 1680 | |4;prototype.html;326.7810566920163;330.20585491892007;333.3582853007959;337.3001022877529;340.7682775712515;6888.3111688831095;6978.2672819353875;7024.332688394601;7052.682629281682;7060.894086588699;6940.7917762467205;6951.75668851589;6963.860722785541;7009.264027277139;7014.508984371096;5063.772130254148;5068.594512438996;5075.822346217892;5093.802956305265;5112.769925353349;5049.697018178903;5090.872728181788;5092.541671249587;5098.796048158069;5101.311322971388;5010.674306170105;5014.5737612303;5018.548330650241;5044.117279476095;5066.771995260204;3845.3270677631444;4918.2376731606655;4980.526849949249;5049.495050494939;5069.873253168664;3945.8618948336957;4157.147784704129;4163.208990291835;4178.415021896906;4185.727927684691;5251.816186433456;6073.787417440369;6645.102911106987;6654.600723956578;6661.26726060133;5862.560307976876;5891.440313170242;5906.291245050578;5922.082077278029;5935.10973353996;5899.764009439617;6260.342664020258;7112.466565007645;7401.296876796696;7473.290037446434;4510.751908645023;4686.062787442525;4687.578117969365;4694.2723877799;4718.150732868083;7847.76456706294;7873.763787086396;7876.881846772303;7891.8027049323655;7928.405369597303;3666.3400587894434;4743.146233677902;4747.643926705442;4759.833405830779;4782.210935195723;3952.3676211805973;4854.320395144682;4861.392325959255;4863.756812159378;4867.853964381075;5863.179154918314;5873.913326034697;5878.000739874146;5893.499052580579;5929.7547515022325;7224.819379515554;7457.962710186523;7479.513831600929;7479.813004674927;7484.363829074481;1654.4374912529797;1677.7651128841972;1682.3691115831564;1684.3851994022093;1686.0726600369749;1001.1490233301781;1052.289704449509;1063.1494804156798;1073.2809017957832;1080.135891286983;6803.081583986099;6806.115205023315;6845.110135682329;6884.862302754017;6909.723611055501;7735.955645987719;7742.8838567421535;7749.108852482037;7750.92249077502;7809.414293927978;6893.75871844483;6916.170059592881;6927.480438967098;6934.549254298455;6947.861042779116;3754.6245375462236;4045.3122969095325;4060.309747342959;4096.1193343431305;4132.380142978577;6625.966870165618;8070.878936815952;8077.232662897133;8107.716229931924;8209;8053.033635963722;8066.637001334954;8070.924183287402;8105.554194519358;8130.227628375294;8128.471649342892;8133.5526546039355;8142.999999999882;8148.633311500997;8153;6633.6351500666;7481.438892083007;7572.583507907118;7817.960910195413;7840.686372545034;7572.167061623107;7626.771196864103;7632.69469221225;7665.885011724717;7679.539227646359;6523.902141467976;8081.878771818545;8111.269985701315;8117.188281171835;8121.878171827546;4750.263709125091;4758.666893317434;4766.142094423037;4770.594499467584;4779;7463.440241981982;7753.263439973193;7850.80372990657;7887.250711182429;7894.921050789649;7503.287187717158;7511.699532018658;7522.736704215326;7528.058992625922;7561.7731468056045;7511.549307041595;7533.6233188339265;7542.019537460095;7542.509736867306;7581.810454738455;7005.563859408707;7348.228436014356;7355.1541572719825;7361.631918403951;7394.741184058532;7475.850482990419;7511.211322811245;7518.135414427192;7528.736494222676;7534.513610508409;5627.690477023803;7176.7488137914925;7351.228121047213;7371.778846634609;7385.556866588022 17:31:07 INFO - PROCESS | 1680 | |5;yui.html;644.2833461167331;664.5766785011423;708.5890183693458;717.103620474407;724.3915111306502;14659.780103298446;15011.024283421584;15051.096934183957;17055;17249.91375043123;15706.450274240375;15742.370305187807;15841.366345346172;15844.28700708468;15869.365225390999;721.213876874207;875.4353442029887;878.1262643669558;898.2723993565234;900.8423525882977;869.604330029838;891.1355984694868;893.1871996483169;896.6278994217392;898.7842917699737;911.5988964855443;932.4125800745521;933.3280038372395;934.9532523373838;936.5036530638738;822.8930239068943;828.4366630691128;902.251131560803;923.796764711769;933.0669330669331;686.9690863911136;689.4105539763531;691.5297597633607;692.4737199728193;696.606417374182;13185.011124165725;14997;15202.771958420633;15217.239138043053;15220.315085821165;12291.938540307241;12551.748965020648;12560.371981400893;12638.49446022158;12862.163959342613;10101;10116.291859569834;10159.847602285972;10172.186225101974;10178.847317290247;3454.827258637058;3488;3490.633483484223;3495.1087472694553;3496.650334966483;56809.43190568083;72661.63669181673;74168.88746668804;74811.62594187049;81886;8504.277136443348;9068;9226.864408888554;9324.25405967521;9423.48170850596;19892.303769368;20003.699944500553;20015;20064.89967550182;20074.799252007586;7198.208197098315;7321.450891183183;7521.962390188014;7550.811229719191;7648.617569121633;3798.3163030654746;4100.425940368351;4227.97886010568;4281.12236991416;4308.224519586442;3478.513008178857;3500.789952602852;3526.3299973005046;3531.1878267998504;3532.6114127445962;661.3584822721951;662.211967758366;662.3310456439032;672.7409947170277;674.0299635148976;498.03277055629684;583.7373182068086;606.4208680709911;617.8239201827547;620.4013127332146;8378.24595786382;8500.857564516678;8623.568821559022;8635.78410539729;8638.611262493203;497.8954419571858;577.8064348443235;593.4453956055379;612.1429998002832;626.589583822597;2856.571514272834;4010.9972506873282;4028.637422631977;4093.774842383638;4329.826806927687;74561.25438745652;78285.60857195791;79096.20903791004;80625;83948.58025709832;70848.64575677192;71117;71840.64079679568;72328.63835680787;72719;62205;62365.064524032176;63590;63723.36276637267;63812.361876380644;8689.869651955352;8693.565321734015;8715.259202967818;8801.251893589117;8937.955310223408;38666.613333867426;49559;49580.25629615487;49742;50409.49590504048;66040.67918641696;66731.66536669337;67804;68702.65648671724;69033.65483172552;10667.573297068031;10773.976472235125;10852.240343175901;11127.443627818415;11731.296122232694;9883.406995580288;10723.517441715298;10953.740319863318;12217.266963982189;12684.936575317064;10763.246572740147;11034;11309.095272378354;11460.14048946349;12090.576829810914;9338.346315757832;10912.61805836792;10978.670639880816;11574.710632233924;11925.880741192477;10836.078933290759;11397.430128493708;11407.657770266573;11464.31214127155;12031.699207519881;8907.73276801697;9108.362414630912;9342.486163260814;9490.572924218288;9711.465869377253;8697.95651021741;8739.344549158712;9624.75938101553;9727.201406198783;9792.706218813448 17:31:07 INFO - PROCESS | 1680 | __end_tp_report 17:31:07 INFO - PROCESS | 1680 | __start_cc_report 17:31:07 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,341 17:31:07 INFO - PROCESS | 1680 | __end_cc_report 17:31:07 INFO - PROCESS | 1680 | __startTimestamp1456363867538__endTimestamp 17:31:07 INFO - PROCESS | 1680 | 17:31:07 INFO - PROCESS | 1680 | ------- Summary: start ------- 17:31:07 INFO - PROCESS | 1680 | Number of tests: 6 17:31:07 INFO - PROCESS | 1680 | 17:31:07 INFO - PROCESS | 1680 | [#0] dojo.html Cycles:165 Average:5726.20 Median:5974.07 stddev:681.48 (11.4%) stddev-sans-first:661.42 17:31:07 INFO - PROCESS | 1680 | Values: 3529.4 3576.1 3577.2 3604.6 3610.7 5768.8 5795.1 5805.7 5807.3 5808.6 5640.5 5667.6 5716.5 5772.8 5833.9 5089.4 5132.9 5153.3 5179.4 5181.0 5242.7 5259.1 5265.8 5295.4 5308.7 5033.6 5081.5 5167.8 5178.8 5224.9 5184.1 5198.6 5203.2 5222.2 5271.5 5046.9 5161.9 5174.7 5176.6 5224.9 4862.3 5043.9 5619.8 5640.2 5711.0 6272.7 6274.4 6281.5 6283.7 6296.5 6168.0 6201.2 6247.4 6252.8 6283.2 5907.1 5916.4 5936.8 5944.5 5974.1 6229.1 6323.1 6324.5 6335.0 6342.1 5204.4 6124.1 6240.7 6243.5 6245.0 5882.9 6160.0 6212.4 6282.5 6336.9 6091.4 6184.0 6196.0 6236.6 6270.3 6291.2 6293.5 6297.7 6303.1 6316.6 4704.1 4919.5 4929.4 4953.8 4953.8 3303.8 3835.0 3921.7 4383.8 4457.8 5758.7 5766.3 5768.8 5780.1 5780.1 6141.7 6252.7 6268.2 6275.6 6281.7 4759.4 4845.7 5774.5 5783.8 5836.8 5410.4 5452.6 5460.5 5461.2 5467.9 6226.0 6314.0 6407.6 6408.4 6412.5 6197.6 6235.7 6246.7 6254.3 6260.3 6362.2 6368.0 6374.1 6385.3 6393.7 6098.5 6148.4 6247.3 6256.7 6267.7 5115.5 5504.8 6192.1 6242.0 6282.2 5954.2 6025.7 6213.8 6217.2 6218.9 5850.6 6181.1 6200.3 6203.9 6210.3 6052.4 6054.5 6064.2 6091.4 6155.8 5394.9 5886.9 6088.2 6134.3 6204.7 6051.0 6052.4 6053.7 6055.1 6059.1 17:31:07 INFO - PROCESS | 1680 | 17:31:07 INFO - PROCESS | 1680 | [#1] ext.html Cycles:180 Average:59716.46 Median:36867.32 stddev:128286.41 (348.0%) stddev-sans-first:128569.06 17:31:07 INFO - PROCESS | 1680 | Values: 426.8 450.0 484.1 558.9 594.2 36149.8 36701.3 36726.6 36840.6 36894.0 37158.4 37645.2 37713.2 37716.8 37724.8 9344.1 9573.2 9610.0 9618.0 9651.4 9427.0 9531.8 9551.8 9567.9 9599.5 9527.8 9559.0 9589.6 9606.3 9634.3 9494.3 9571.3 9575.8 9596.0 9598.5 9433.6 9526.9 9599.3 9606.6 9613.6 36973.3 37012.8 37279.1 37415.8 37495.0 2730.8 3135.8 3202.2 3336.6 3378.3 21621.0 25729.7 26263.5 26583.3 26727.0 2809.5 2819.7 2860.7 2873.5 2967.0 274599.0 329099.4 330583.0 332460.0 333021.0 43297.3 43850.6 43861.0 43872.3 43875.0 42777.4 42908.9 42926.0 43081.6 43217.6 14948.4 15013.8 15027.2 15048.4 15131.8 12066.8 12168.4 12172.7 12321.8 12490.3 13739.3 13743.0 13882.5 13988.7 14321.4 5233.5 6101.3 6147.5 6218.5 6238.5 978.6 978.7 1044.3 1094.4 1153.1 24923.0 29320.6 29340.9 29474.0 29822.8 872.9 1063.1 1088.6 1140.5 1214.5 13737.8 13890.1 13920.9 14921.3 15021.9 597691.0 601823.0 605432.0 609566.0 612976.0 57136.1 57574.4 57662.1 58316.0 58369.7 1448.2 1457.5 1460.0 1460.5 1594.5 22725.5 28534.3 29872.9 30254.7 30437.0 50706.5 50714.7 50727.5 51252.7 51258.0 463753.7 470335.0 472419.0 473678.0 474120.0 32833.7 43267.0 43664.6 44143.6 44145.8 42437.2 43028.1 43869.0 43912.1 44771.8 31385.4 34586.8 35992.8 36312.8 36356.0 35792.6 36123.0 36203.5 36310.6 36349.8 31674.0 35820.0 35936.1 36307.5 36898.0 24284.4 29748.8 30412.5 30455.7 30472.4 18675.3 25164.9 25298.7 25471.4 25658.4 17:31:07 INFO - PROCESS | 1680 | 17:31:07 INFO - PROCESS | 1680 | [#2] jquery.html Cycles:180 Average:34175.84 Median:12914.98 stddev:102556.45 (794.1%) stddev-sans-first:102812.71 17:31:07 INFO - PROCESS | 1680 | Values: 357.4 361.3 361.6 365.7 368.5 14665.9 18506.6 18623.3 18708.6 19318.8 18476.9 18843.4 18865.8 18969.4 19177.4 5408.0 5488.9 5648.1 5694.3 5733.9 5534.7 5550.2 5611.3 5623.2 5647.7 5411.4 5580.6 5605.7 5612.6 5637.1 5503.6 5542.4 5567.5 5573.0 5589.4 5277.6 5345.9 5372.5 5380.8 5383.8 9935.3 12187.9 12719.6 18098.3 23671.5 1743.1 1995.0 2158.4 2394.3 2548.3 9667.3 11017.9 13806.9 14149.9 14832.9 1470.8 1828.5 1857.6 1886.8 1964.9 83171.2 95159.6 105153.5 108749.0 110262.0 11163.6 11171.6 11283.6 11290.2 11396.4 12096.7 12649.7 13236.5 13442.0 13443.2 8088.2 8183.6 8318.0 8329.8 8363.9 8377.0 8377.4 8460.6 8536.4 8547.5 3804.3 4022.1 4372.0 4418.7 4443.6 1871.6 1895.3 1920.2 1922.3 1941.3 885.2 892.3 929.4 982.7 1068.4 17905.3 19048.9 19356.7 19442.0 19746.6 925.3 946.4 971.8 975.7 984.3 8345.7 10622.5 10652.4 10674.8 10706.5 595041.0 600708.0 615174.0 635200.0 644979.0 119491.0 119701.4 120180.0 120541.0 121706.0 1013.8 1014.7 1016.9 1029.9 1038.6 17613.9 17926.7 18062.0 18526.4 18527.1 41005.8 50279.0 52589.9 53172.4 56179.0 73098.0 73251.6 73296.3 74433.6 74785.0 6612.4 7840.0 7985.7 8088.0 8159.7 9399.4 12386.4 13387.5 13472.9 13564.9 10357.2 10788.2 11169.2 11259.8 11437.8 10165.2 10280.1 10289.9 10969.2 11006.6 11365.8 11541.4 11774.4 11850.4 11872.9 8009.8 8060.6 8073.0 8085.4 8115.5 9093.8 11603.5 11603.5 11619.9 11623.1 17:31:07 INFO - PROCESS | 1680 | 17:31:07 INFO - PROCESS | 1680 | [#3] mootools.html Cycles:180 Average:5905.42 Median:5450.02 stddev:3128.96 (57.4%) stddev-sans-first:3120.34 17:31:07 INFO - PROCESS | 1680 | Values: 1515.4 1522.2 1756.6 1891.5 1906.4 6597.0 6792.6 8617.9 8705.3 8740.3 8515.5 8535.8 8658.0 8662.6 8681.3 2418.2 2442.6 2445.0 2457.0 2463.4 2419.5 2501.6 2517.0 2517.1 2529.4 2140.9 2370.7 2378.8 2391.8 2476.5 2412.8 2439.6 2445.5 2445.8 2451.3 2094.8 2401.8 2430.3 2433.9 2434.6 8509.9 8563.2 8563.4 8588.1 8604.5 5287.8 5382.6 5422.6 5431.4 5488.6 3535.9 3580.7 3642.8 3646.4 3663.1 1056.2 1078.9 1080.1 1086.3 1090.9 11652.8 11687.9 11793.9 11851.3 11857.9 4307.2 4615.9 4845.9 4891.2 4936.0 10139.3 10146.2 10201.4 10203.6 10235.9 5442.3 5457.7 5468.3 5487.6 5490.9 4918.1 4931.7 4959.5 4967.3 4975.0 3817.6 3837.1 3838.3 3889.1 3898.0 1268.6 1278.6 1280.1 1280.3 1302.2 1024.1 1113.8 1126.3 1132.8 1341.3 6097.9 6620.4 6952.1 7810.0 7954.5 524.6 609.8 629.6 636.1 752.7 4931.3 5507.7 5767.9 5859.5 6103.5 8867.6 10182.6 10486.3 10573.0 10579.0 10133.1 10535.6 10552.0 10615.6 10650.6 8021.4 8078.5 8174.3 8191.4 8204.4 7744.9 7846.6 7865.8 7891.5 7925.5 9095.7 9201.4 9275.9 9310.9 9434.8 9470.1 9650.0 9682.2 9804.9 9878.9 7845.3 8101.2 8122.9 8165.0 8171.3 8091.6 8149.3 8160.8 8205.0 8222.1 6088.3 6529.3 7266.3 7357.3 7369.3 6957.9 6990.5 7011.2 7106.4 7120.7 7469.9 7476.4 7478.2 7481.8 7560.8 6664.0 6696.8 6710.4 6744.0 6770.2 6777.3 6899.2 6922.5 6924.0 6931.4 17:31:07 INFO - PROCESS | 1680 | 17:31:07 INFO - PROCESS | 1680 | [#4] prototype.html Cycles:180 Average:6030.25 Median:6891.03 stddev:1997.04 (29.0%) stddev-sans-first:1956.23 17:31:07 INFO - PROCESS | 1680 | Values: 326.8 330.2 333.4 337.3 340.8 6888.3 6978.3 7024.3 7052.7 7060.9 6940.8 6951.8 6963.9 7009.3 7014.5 5063.8 5068.6 5075.8 5093.8 5112.8 5049.7 5090.9 5092.5 5098.8 5101.3 5010.7 5014.6 5018.5 5044.1 5066.8 3845.3 4918.2 4980.5 5049.5 5069.9 3945.9 4157.1 4163.2 4178.4 4185.7 5251.8 6073.8 6645.1 6654.6 6661.3 5862.6 5891.4 5906.3 5922.1 5935.1 5899.8 6260.3 7112.5 7401.3 7473.3 4510.8 4686.1 4687.6 4694.3 4718.2 7847.8 7873.8 7876.9 7891.8 7928.4 3666.3 4743.1 4747.6 4759.8 4782.2 3952.4 4854.3 4861.4 4863.8 4867.9 5863.2 5873.9 5878.0 5893.5 5929.8 7224.8 7458.0 7479.5 7479.8 7484.4 1654.4 1677.8 1682.4 1684.4 1686.1 1001.1 1052.3 1063.1 1073.3 1080.1 6803.1 6806.1 6845.1 6884.9 6909.7 7736.0 7742.9 7749.1 7750.9 7809.4 6893.8 6916.2 6927.5 6934.5 6947.9 3754.6 4045.3 4060.3 4096.1 4132.4 6626.0 8070.9 8077.2 8107.7 8209.0 8053.0 8066.6 8070.9 8105.6 8130.2 8128.5 8133.6 8143.0 8148.6 8153.0 6633.6 7481.4 7572.6 7818.0 7840.7 7572.2 7626.8 7632.7 7665.9 7679.5 6523.9 8081.9 8111.3 8117.2 8121.9 4750.3 4758.7 4766.1 4770.6 4779.0 7463.4 7753.3 7850.8 7887.3 7894.9 7503.3 7511.7 7522.7 7528.1 7561.8 7511.5 7533.6 7542.0 7542.5 7581.8 7005.6 7348.2 7355.2 7361.6 7394.7 7475.9 7511.2 7518.1 7528.7 7534.5 5627.7 7176.7 7351.2 7371.8 7385.6 17:31:07 INFO - PROCESS | 1680 | 17:31:07 INFO - PROCESS | 1680 | [#5] yui.html Cycles:180 Average:17248.84 Median:32108.29 stddev:23271.92 (72.5%) stddev-sans-first:23303.80 17:31:07 INFO - PROCESS | 1680 | Values: 644.3 664.6 708.6 717.1 724.4 14659.8 15011.0 15051.1 17055.0 17249.9 15706.5 15742.4 15841.4 15844.3 15869.4 721.2 875.4 878.1 898.3 900.8 869.6 891.1 893.2 896.6 898.8 911.6 932.4 933.3 935.0 936.5 822.9 828.4 902.3 923.8 933.1 687.0 689.4 691.5 692.5 696.6 13185.0 14997.0 15202.8 15217.2 15220.3 12291.9 12551.7 12560.4 12638.5 12862.2 10101.0 10116.3 10159.8 10172.2 10178.8 3454.8 3488.0 3490.6 3495.1 3496.7 56809.4 72661.6 74168.9 74811.6 81886.0 8504.3 9068.0 9226.9 9324.3 9423.5 19892.3 20003.7 20015.0 20064.9 20074.8 7198.2 7321.5 7522.0 7550.8 7648.6 3798.3 4100.4 4228.0 4281.1 4308.2 3478.5 3500.8 3526.3 3531.2 3532.6 661.4 662.2 662.3 672.7 674.0 498.0 583.7 606.4 617.8 620.4 8378.2 8500.9 8623.6 8635.8 8638.6 497.9 577.8 593.4 612.1 626.6 2856.6 4011.0 4028.6 4093.8 4329.8 74561.3 78285.6 79096.2 80625.0 83948.6 70848.6 71117.0 71840.6 72328.6 72719.0 62205.0 62365.1 63590.0 63723.4 63812.4 8689.9 8693.6 8715.3 8801.3 8938.0 38666.6 49559.0 49580.3 49742.0 50409.5 66040.7 66731.7 67804.0 68702.7 69033.7 10667.6 10774.0 10852.2 11127.4 11731.3 9883.4 10723.5 10953.7 12217.3 12684.9 10763.2 11034.0 11309.1 11460.1 12090.6 9338.3 10912.6 10978.7 11574.7 11925.9 10836.1 11397.4 11407.7 11464.3 12031.7 8907.7 9108.4 9342.5 9490.6 9711.5 8698.0 8739.3 9624.8 9727.2 9792.7 17:31:07 INFO - PROCESS | 1680 | -------- Summary: end -------- 17:31:07 INFO - PROCESS | 1680 | 17:31:08 INFO - TEST-INFO | 1680: exit 0 17:31:08 INFO - TEST-OK | dromaeo_css | took 1111191ms 17:31:08 INFO - TEST-START | kraken 17:31:08 INFO - operating with platform_type : mac_ 17:31:08 INFO - Initialising browser for kraken test... 17:31:08 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/tmp5_Ekda/profile http://localhost:49279/getInfo.html) 17:31:10 INFO - PROCESS | 1689 | __metrics Screen width/height:1600/1200 17:31:10 INFO - PROCESS | 1689 | colorDepth:24 17:31:10 INFO - PROCESS | 1689 | Browser inner width/height: 1024/689 17:31:10 INFO - PROCESS | 1689 | __metrics 17:31:10 ERROR - PROCESS | 1689 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 17:31:11 INFO - TEST-INFO | 1689: exit 0 17:31:11 INFO - Browser initialized. 17:31:11 INFO - Running cycle 1/1 for kraken test... 17:31:11 INFO - TEST-INFO | started process 1692 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/tmp5_Ekda/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:31:23 INFO - PROCESS | 1692 | RSS: Main: 255995904 17:31:23 INFO - PROCESS | 1692 | 17:31:26 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 17:31:26 INFO - PROCESS | 1692 | RSS: Main: 269258752 17:31:26 INFO - PROCESS | 1692 | 17:31:29 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 17:31:29 INFO - PROCESS | 1692 | RSS: Main: 277426176 17:31:29 INFO - PROCESS | 1692 | 17:31:33 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 17:31:33 INFO - PROCESS | 1692 | RSS: Main: 279089152 17:31:33 INFO - PROCESS | 1692 | 17:31:41 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 17:31:42 INFO - PROCESS | 1692 | RSS: Main: 280547328 17:31:42 INFO - PROCESS | 1692 | 17:31:44 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:31:44 INFO - PROCESS | 1692 | RSS: Main: 280997888 17:31:44 INFO - PROCESS | 1692 | 17:31:47 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 17:31:48 INFO - PROCESS | 1692 | RSS: Main: 282705920 17:31:48 INFO - PROCESS | 1692 | 17:31:51 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 17:31:51 INFO - PROCESS | 1692 | RSS: Main: 283332608 17:31:51 INFO - PROCESS | 1692 | 17:31:54 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 17:31:55 INFO - PROCESS | 1692 | RSS: Main: 283299840 17:31:55 INFO - PROCESS | 1692 | 17:31:57 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:31:57 INFO - PROCESS | 1692 | RSS: Main: 282742784 17:31:57 INFO - PROCESS | 1692 | 17:31:59 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:32:00 INFO - PROCESS | 1692 | RSS: Main: 281784320 17:32:00 INFO - PROCESS | 1692 | 17:32:02 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:32:03 INFO - PROCESS | 1692 | RSS: Main: 283578368 17:32:03 INFO - PROCESS | 1692 | 17:32:05 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:32:06 INFO - PROCESS | 1692 | RSS: Main: 281964544 17:32:06 INFO - PROCESS | 1692 | 17:32:08 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:32:09 INFO - PROCESS | 1692 | RSS: Main: 282202112 17:32:09 INFO - PROCESS | 1692 | 17:32:11 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 17:32:11 INFO - PROCESS | 1692 | RSS: Main: 283914240 17:32:11 INFO - PROCESS | 1692 | 17:32:11 INFO - PROCESS | 1692 | __start_tp_report 17:32:11 INFO - PROCESS | 1692 | _x_x_mozilla_page_load 17:32:11 INFO - PROCESS | 1692 | _x_x_mozilla_page_load_details 17:32:11 INFO - PROCESS | 1692 | |i|pagename|runs| 17:32:11 INFO - PROCESS | 1692 | |0;ai-astar;113;108;115;114;114;126;112;113;116;140 17:32:11 INFO - PROCESS | 1692 | |1;audio-beat-detection;183;121;143;155;122;146;143;123;161;125 17:32:11 INFO - PROCESS | 1692 | |2;audio-dft;193;196;201;203;205;223;242;272;207;199 17:32:11 INFO - PROCESS | 1692 | |3;audio-fft;69;71;71;104;55;57;61;58;107;58 17:32:11 INFO - PROCESS | 1692 | |4;audio-oscillator;84;84;121;80;81;83;114;79;80;112 17:32:11 INFO - PROCESS | 1692 | |5;imaging-gaussian-blur;86;95;87;92;86;93;86;93;87;95 17:32:11 INFO - PROCESS | 1692 | |6;imaging-darkroom;112;96;94;95;96;108;95;102;155;156 17:32:11 INFO - PROCESS | 1692 | |7;imaging-desaturate;146;132;90;88;135;144;148;91;131;150 17:32:11 INFO - PROCESS | 1692 | |8;json-parse-financial;54;56;52;62;67;51;50;72;87;87 17:32:11 INFO - PROCESS | 1692 | |9;json-stringify-tinderbox;64;64;82;89;61;90;102;98;91;66 17:32:11 INFO - PROCESS | 1692 | |10;stanford-crypto-aes;89;86;84;86;85;86;86;86;88;86 17:32:11 INFO - PROCESS | 1692 | |11;stanford-crypto-ccm;124;127;128;134;124;131;141;136;119;125 17:32:11 INFO - PROCESS | 1692 | |12;stanford-crypto-pbkdf2;138;140;139;141;144;180;132;144;143;128 17:32:11 INFO - PROCESS | 1692 | |13;stanford-crypto-sha256-iterative;56;89;97;96;63;87;98;97;99;72 17:32:11 INFO - PROCESS | 1692 | __end_tp_report 17:32:11 INFO - PROCESS | 1692 | __start_cc_report 17:32:11 INFO - PROCESS | 1692 | _x_x_mozilla_cycle_collect,887 17:32:11 INFO - PROCESS | 1692 | __end_cc_report 17:32:11 INFO - PROCESS | 1692 | __startTimestamp1456363931403__endTimestamp 17:32:11 INFO - PROCESS | 1692 | 17:32:11 INFO - PROCESS | 1692 | ------- Summary: start ------- 17:32:11 INFO - PROCESS | 1692 | Number of tests: 14 17:32:11 INFO - PROCESS | 1692 | 17:32:11 INFO - PROCESS | 1692 | [#0] ai-astar Cycles:10 Average:117.10 Median:114.50 stddev:9.26 (8.1%) stddev-sans-first:9.70 17:32:11 INFO - PROCESS | 1692 | Values: 113.0 108.0 115.0 114.0 114.0 126.0 112.0 113.0 116.0 140.0 17:32:11 INFO - PROCESS | 1692 | 17:32:11 INFO - PROCESS | 1692 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:144.50 stddev:20.33 (14.1%) stddev-sans-first:15.29 17:32:11 INFO - PROCESS | 1692 | Values: 183.0 121.0 143.0 155.0 122.0 146.0 143.0 123.0 161.0 125.0 17:32:11 INFO - PROCESS | 1692 | 17:32:11 INFO - PROCESS | 1692 | [#2] audio-dft Cycles:10 Average:214.10 Median:206.00 stddev:25.03 (12.2%) stddev-sans-first:25.36 17:32:11 INFO - PROCESS | 1692 | Values: 193.0 196.0 201.0 203.0 205.0 223.0 242.0 272.0 207.0 199.0 17:32:11 INFO - PROCESS | 1692 | 17:32:11 INFO - PROCESS | 1692 | [#3] audio-fft Cycles:10 Average:71.10 Median:59.50 stddev:19.09 (32.1%) stddev-sans-first:20.23 17:32:11 INFO - PROCESS | 1692 | Values: 69.0 71.0 71.0 104.0 55.0 57.0 61.0 58.0 107.0 58.0 17:32:11 INFO - PROCESS | 1692 | 17:32:11 INFO - PROCESS | 1692 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:80.50 stddev:16.71 (20.8%) stddev-sans-first:17.48 17:32:11 INFO - PROCESS | 1692 | Values: 84.0 84.0 121.0 80.0 81.0 83.0 114.0 79.0 80.0 112.0 17:32:11 INFO - PROCESS | 1692 | 17:32:11 INFO - PROCESS | 1692 | [#5] imaging-gaussian-blur Cycles:10 Average:90.00 Median:92.50 stddev:3.92 (4.2%) stddev-sans-first:3.88 17:32:11 INFO - PROCESS | 1692 | Values: 86.0 95.0 87.0 92.0 86.0 93.0 86.0 93.0 87.0 95.0 17:32:11 INFO - PROCESS | 1692 | 17:32:11 INFO - PROCESS | 1692 | [#6] imaging-darkroom Cycles:10 Average:110.90 Median:94.50 stddev:24.27 (25.7%) stddev-sans-first:25.74 17:32:11 INFO - PROCESS | 1692 | Values: 112.0 96.0 94.0 95.0 96.0 108.0 95.0 102.0 155.0 156.0 17:32:11 INFO - PROCESS | 1692 | 17:32:11 INFO - PROCESS | 1692 | [#7] imaging-desaturate Cycles:10 Average:125.50 Median:149.00 stddev:25.58 (17.2%) stddev-sans-first:26.03 17:32:11 INFO - PROCESS | 1692 | Values: 146.0 132.0 90.0 88.0 135.0 144.0 148.0 91.0 131.0 150.0 17:32:11 INFO - PROCESS | 1692 | 17:32:11 INFO - PROCESS | 1692 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.50 stddev:14.17 (22.0%) stddev-sans-first:14.58 17:32:11 INFO - PROCESS | 1692 | Values: 54.0 56.0 52.0 62.0 67.0 51.0 50.0 72.0 87.0 87.0 17:32:11 INFO - PROCESS | 1692 | 17:32:11 INFO - PROCESS | 1692 | [#9] json-stringify-tinderbox Cycles:10 Average:80.70 Median:85.50 stddev:15.56 (18.2%) stddev-sans-first:15.28 17:32:11 INFO - PROCESS | 1692 | Values: 64.0 64.0 82.0 89.0 61.0 90.0 102.0 98.0 91.0 66.0 17:32:11 INFO - PROCESS | 1692 | 17:32:11 INFO - PROCESS | 1692 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:86.00 stddev:1.40 (1.6%) stddev-sans-first:1.05 17:32:11 INFO - PROCESS | 1692 | Values: 89.0 86.0 84.0 86.0 85.0 86.0 86.0 86.0 88.0 86.0 17:32:11 INFO - PROCESS | 1692 | 17:32:11 INFO - PROCESS | 1692 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:129.50 stddev:6.61 (5.1%) stddev-sans-first:6.77 17:32:11 INFO - PROCESS | 1692 | Values: 124.0 127.0 128.0 134.0 124.0 131.0 141.0 136.0 119.0 125.0 17:32:11 INFO - PROCESS | 1692 | 17:32:11 INFO - PROCESS | 1692 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.90 Median:142.00 stddev:14.03 (9.9%) stddev-sans-first:14.77 17:32:11 INFO - PROCESS | 1692 | Values: 138.0 140.0 139.0 141.0 144.0 180.0 132.0 144.0 143.0 128.0 17:32:11 INFO - PROCESS | 1692 | 17:32:11 INFO - PROCESS | 1692 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:85.40 Median:96.50 stddev:15.94 (16.5%) stddev-sans-first:12.87 17:32:11 INFO - PROCESS | 1692 | Values: 56.0 89.0 97.0 96.0 63.0 87.0 98.0 97.0 99.0 72.0 17:32:11 INFO - PROCESS | 1692 | -------- Summary: end -------- 17:32:11 INFO - PROCESS | 1692 | 17:32:12 INFO - TEST-INFO | 1692: exit 0 17:32:12 INFO - TEST-OK | kraken | took 64068ms 17:32:12 INFO - SUITE-END | took 1175s 17:32:12 INFO - Completed test suite (00:19:35) 17:32:12 INFO - Working with test: dromaeo_css 17:32:12 INFO - Generating results file: dromaeo_css 17:32:12 INFO - Working with test: kraken 17:32:12 INFO - Generating results file: kraken 17:32:12 INFO - javascript benchmark 17:32:12 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:32:12 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 17:32:12 INFO - process_Request line: dromaeo_css 7417.51 graph.html#tests=[[72,1,61]] 17:32:12 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:32:12 INFO - process_Request line: kraken 1550.60 graph.html#tests=[[232,1,61]] 17:32:12 INFO - RETURN: dromaeo_css: 7417.51 17:32:12 INFO - RETURN: kraken: 1550.60 17:32:12 INFO - javascript benchmark 17:32:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3529.364714351417, 3576.1059735066233, 3577.177249232675, 3604.6395360463957, 3610.747247692662, 5768.798092066773, 5795.101759227316, 5805.680687562182, 5807.274090738658, 5808.59339846211, 5640.492355687988, 5667.5749318801045, 5716.456936591027, 5772.769089236425, 5833.854153646161, 5089.389273287202, 5132.923006154911, 5153.304303918961, 5179.378474583055, 5181.041507321139, 5242.711650859202, 5259.0796610593, 5265.842024739245, 5295.391030031557, 5308.681479111266, 5033.622478314122, 5081.542661160494, 5167.819126330561, 5178.844634660966, 5224.947750522484, 5184.144616138333, 5198.584113270929, 5203.19350500673, 5222.216667499867, 5271.472852714736, 5046.873828154289, 5161.870953226162, 5174.689518628894, 5176.637635365526, 5224.8693782655355, 4862.270659401082, 5043.8903441242865, 5619.831405057855, 5640.153976903456, 5711.000574899376, 6272.686365681698, 6274.435300822902, 6281.466075383598, 6283.717232724538, 6296.527760417941, 6168.043953187218, 6201.224846894138, 6247.375262473762, 6252.843678908018, 6283.151774510428, 5907.14346419771, 5916.437938395846, 5936.8218953430605, 5944.524438044946, 5974.074018527135, 6229.127922090911, 6323.114763933053, 6324.525660575383, 6334.968325158345, 6342.112104305401, 5204.375474943031, 6124.136831511551, 6240.65676387794, 6243.531735119885, 6245.0, 5882.911756323659, 6159.952808022647, 6212.409821067082, 6282.528810339243, 6336.904946425807, 6091.42131497507, 6183.9565381783195, 6195.96902015487, 6236.594621349688, 6270.2789179244055, 6291.213598300213, 6293.465055470337, 6297.716602752887, 6303.054541818764, 6316.621002739758, 4704.059188162381, 4919.4834542373255, 4929.433115191727, 4953.752312384367, 4953.801847926043, 3303.768736188492, 3834.9808250959127, 3921.7058370737586, 4383.824647014148, 4457.840961350007, 5758.712064396764, 5766.250387449689, 5768.798092066758, 5780.132980053026, 5780.132980053026, 6141.692915354214, 6252.749890004349, 6268.1851359323, 6275.623462592259, 6281.685915704196, 4759.357486739315, 4845.685030473008, 5774.480296773227, 5783.797567085132, 5836.7957121501395, 5410.404855465896, 5452.618316717871, 5460.453954604587, 5461.2354270402175, 5467.863303417446, 6226.034964580497, 6314.021326694462, 6407.615543067338, 6408.391202835724, 6412.454941330039, 6197.628142311476, 6235.719392627433, 6246.656433896179, 6254.312025677263, 6260.342664020212, 6362.204724409449, 6368.044793281045, 6374.139491168633, 6385.329540398191, 6393.680315984275, 6098.522998456991, 6148.385161483816, 6247.2815626201755, 6256.687165641609, 6267.686615669107, 5115.514026167508, 5504.834854954358, 6192.102145188832, 6242.0, 6282.151909492343, 5954.166416701752, 6025.698715064317, 6213.813585592258, 6217.222847144107, 6218.9116904542425, 5850.64896106235, 6181.072839074175, 6200.286966998672, 6203.875922481616, 6210.285817131088, 6052.364501727256, 6054.515638748801, 6064.211652485149, 6091.360407157184, 6155.815325540241, 5394.946050539601, 5886.882262354643, 6088.178095957166, 6134.283518479682, 6204.72078756448, 6050.969745151246, 6052.425019623129, 6053.697315134314, 6055.091736239599, 6059.121427393092], "unit": "score", "name": "dojo.html", "value": 5682.699102033239}, {"lowerIsBetter": false, "replicates": [426.7738098807633, 449.9707519011266, 484.1164874104759, 558.9240711630113, 594.1829983772313, 36149.81925090374, 36701.26597468049, 36726.63273367265, 36840.631593684055, 36893.99999999996, 37158.44262336061, 37645.24709505808, 37713.24573508535, 37716.81141594288, 37724.811375943085, 9344.112309330603, 9573.234141268682, 9609.951950240238, 9617.990111038345, 9651.372660777028, 9427.010163932791, 9531.80936381272, 9551.761205969871, 9567.904320956772, 9599.520023998806, 9527.761805954837, 9559.044095590454, 9589.616415343378, 9606.327557071008, 9634.277429192838, 9494.335396522247, 9571.330006899554, 9575.760605984837, 9596.0, 9598.520073996307, 9433.575489103006, 9526.85709714355, 9599.32804703671, 9606.567704453317, 9613.567389467491, 36973.26053478942, 37012.81493592515, 37279.06802329936, 37415.812920935496, 37495.0, 2730.754232119119, 3135.764817638686, 3202.247471844115, 3336.6496517865517, 3378.290558982592, 21621.0, 25729.742702572923, 26263.474730505473, 26583.335416614547, 26727.0, 2809.5364264896266, 2819.6898341182455, 2860.7425331720247, 2873.482773100841, 2967.0, 274599.0, 329099.35450322833, 330583.0, 332460.0, 333021.0, 43297.268109275275, 43850.561494385285, 43861.0, 43872.3419148713, 43875.0, 42777.35833962493, 42908.92727681833, 42926.0, 43081.569184308384, 43217.56782432198, 14948.402063917321, 15013.774793378108, 15027.248637568078, 15048.398064077533, 15131.848681513044, 12066.75866482683, 12168.391580420943, 12172.695682607828, 12321.753564928651, 12490.313032783102, 13739.313034348243, 13743.0, 13882.51411200603, 13988.72022559543, 14321.35553900077, 5233.502817232356, 6101.267847858286, 6147.477464415575, 6218.533609979269, 6238.532110091761, 978.6036655154531, 978.6819283732815, 1044.3107549017764, 1094.3503416107212, 1153.1234972460845, 24923.003079876966, 29320.560191596716, 29340.85329573381, 29473.968411105507, 29822.807087716683, 872.8559787635096, 1063.0751246415668, 1088.5972190289644, 1140.509580880213, 1214.4595654933646, 13737.793933091012, 13890.09714368583, 13920.930395348161, 14921.3285402155, 15021.920014315, 597691.0, 601823.0, 605432.0, 609566.0, 612976.0, 57136.14295785566, 57574.424255757745, 57662.13506797401, 58316.0, 58369.70815145897, 1448.2034880815509, 1457.5263039512201, 1459.9708005840037, 1460.5107289058285, 1594.5296137639425, 22725.545489089796, 28534.286642834097, 29872.850635746683, 30254.697453025186, 30437.0, 50706.492935071656, 50714.73213169553, 50727.492725072276, 51252.74373628108, 51258.0, 463753.6812316052, 470335.0, 472419.0, 473678.0, 474120.0, 32833.671663283065, 43267.0, 43664.56335436732, 44143.55856441394, 44145.77927110472, 42437.22872369556, 43028.139437210455, 43869.0, 43912.121757565306, 44771.77614111909, 31385.37229255448, 34586.82706586451, 35992.820035899655, 36312.818435907655, 36356.0, 35792.64207357893, 36123.0, 36203.456948146326, 36310.63689363178, 36349.818250908575, 31674.0, 35820.0, 35936.10159746027, 36307.45538816973, 36898.0, 24284.392890177885, 29748.81004759872, 30412.5438118424, 30455.695443045286, 30472.390552189274, 18675.346362877233, 25164.874175629004, 25298.747012530377, 25471.36321591975, 25658.358541036625], "unit": "score", "name": "ext.html", "value": 18488.226859847742}, {"lowerIsBetter": false, "replicates": [357.383513439317, 361.2684314263616, 361.5570925616121, 365.70377993825, 368.5154022460463, 14665.92667036666, 18506.629867402677, 18623.348182813603, 18708.625827483458, 19318.806811931878, 18476.907615461936, 18843.43469695908, 18865.811341886576, 18969.430917072474, 19177.42467725967, 5407.972960135194, 5488.862778430551, 5648.068068768669, 5694.345150307726, 5733.913991290134, 5534.667919924797, 5550.16747487878, 5611.270534830466, 5623.156526521014, 5647.689377084259, 5411.404745478014, 5580.581456390767, 5605.691686957216, 5612.635178713391, 5637.098064309711, 5503.587230957694, 5542.418046105182, 5567.47109024642, 5573.024720673886, 5589.413111623282, 5277.6041796865, 5345.919811202835, 5372.489613486712, 5380.811671591515, 5383.784648614051, 9935.254855885838, 12187.878121218762, 12719.618411447671, 18098.27606895736, 23671.526569468686, 1743.111013383171, 1994.9700754488695, 2158.4280165756086, 2394.341556072077, 2548.324693956103, 9667.27495437838, 11017.944910275477, 13806.895448364106, 14149.858501414958, 14832.925835370863, 1470.8235011798545, 1828.5245836082581, 1857.6099019205983, 1886.8018858019984, 1964.8919309437974, 83171.16828831755, 95159.57260641096, 105153.47423262912, 108749.0, 110262.0, 11163.553457861595, 11171.553137874556, 11283.605073822377, 11290.153238507144, 11396.430178491042, 12096.697582560506, 12649.747005060031, 13236.536721214712, 13442.0, 13443.193408395331, 8088.150744171778, 8183.590820458953, 8317.95841020791, 8329.750107496784, 8363.916360836436, 8376.958115209385, 8377.37169712274, 8460.576971151419, 8536.359773017048, 8547.487150770974, 3804.2581696568905, 4022.0749227677798, 4371.9944412785235, 4418.712783669115, 4443.600075993176, 1871.606962537855, 1895.2987394663787, 1920.19351872214, 1922.3079691311116, 1941.2914286285404, 885.1590988560893, 892.2638822971074, 929.3958926697701, 982.7051884434641, 1068.4497483795851, 17905.28378864857, 19048.85706857593, 19356.70964935527, 19442.0, 19746.605067898563, 925.3013974449382, 946.3612061858219, 971.8153550825461, 975.6633961283346, 984.2618036472645, 8345.66617335312, 10622.521986510626, 10652.414117223627, 10674.78650426987, 10706.46467676613, 595041.0, 600708.0, 615174.0, 635200.0, 644979.0, 119491.0, 119701.40149299198, 120180.0, 120541.0, 121706.0, 1013.7769690668041, 1014.6905193915779, 1016.8779746430475, 1029.9021592948807, 1038.6312858934969, 17613.943163410237, 17926.731099033786, 18062.006589637695, 18526.351577694717, 18527.0736463179, 41005.79497102495, 50279.0, 52589.94820103653, 53172.40482785523, 56179.0, 73098.0, 73251.63374183096, 73296.26703733108, 74433.62783186049, 74785.0, 6612.437942774918, 7840.0199975003125, 7985.72049978248, 8088.018435483109, 8159.714409995621, 9399.389039712396, 12386.442610082388, 13387.531436399679, 13472.86527134716, 13564.93217533906, 10357.22320825926, 10788.244822862323, 11169.162312826733, 11259.831102533632, 11437.828432573684, 10165.203229356985, 10280.07479326864, 10289.9485502572, 10969.23215374948, 11006.614768483065, 11365.829512557153, 11541.422928853355, 11774.411279435823, 11850.407479625812, 11872.881271187178, 8009.8398032040195, 8060.637271322687, 8073.0, 8085.39359548048, 8115.513069215866, 9093.818123637358, 11603.477843497232, 11603.535858565563, 11619.883801161881, 11623.07015438746], "unit": "score", "name": "jquery.html", "value": 9163.92869729982}, {"lowerIsBetter": false, "replicates": [1515.3559737111727, 1522.2388805597202, 1756.5959829239275, 1891.527118220445, 1906.428071578526, 6597.0, 6792.592444453337, 8617.91382086179, 8705.303575713944, 8740.300775937918, 8515.531645759496, 8535.829283414329, 8657.95671021644, 8662.566871656407, 8681.305495560357, 2418.17781954136, 2442.6091825307954, 2445.0, 2457.0294733580226, 2463.4087818923417, 2419.458667168452, 2501.6247562865533, 2517.0435234610914, 2517.0938462153704, 2529.4182338062255, 2140.9464763380884, 2370.668106465096, 2378.762123787616, 2391.820613453989, 2476.5170791695627, 2412.7949124324455, 2439.621858611918, 2445.5231229910173, 2445.8410203336903, 2451.3013791069548, 2094.759102703178, 2401.8318717689767, 2430.283066495388, 2433.9391515212083, 2434.5982912819363, 8509.914900851036, 8563.229309362125, 8563.44337618059, 8588.141185881424, 8604.52675102869, 5287.762050707689, 5382.569394448435, 5422.566194704415, 5431.429699881534, 5488.56091512682, 3535.876244331436, 3580.6598373154507, 3642.8360723767496, 3646.3801153803915, 3663.084228942764, 1056.2025670618634, 1078.8759292681284, 1080.1089101491302, 1086.315621158665, 1090.907272881806, 11652.76694466106, 11687.883121168765, 11793.879581439835, 11851.288922664668, 11857.940710296394, 4307.246231909403, 4615.884602884955, 4845.9030819383415, 4891.217405215149, 4935.975320123448, 10139.2902496826, 10146.239032072624, 10201.38791672502, 10203.642872499428, 10235.948820256, 5442.319710036246, 5457.727113644302, 5468.316460442445, 5487.64330318528, 5490.945090549123, 4918.139325618003, 4931.679440836334, 4959.479254678279, 4967.304577359173, 4974.975125124423, 3817.5800661927165, 3837.136644255076, 3838.347480928249, 3889.124946886984, 3898.0, 1268.6447794617523, 1278.619091381306, 1280.1231156657534, 1280.2638482872198, 1302.2316833068535, 1024.1397226329918, 1113.8050841102774, 1126.2679258482053, 1132.8300754886832, 1341.336038660869, 6097.87189369968, 6620.404163625297, 6952.130983627047, 7810.0, 7954.522728636301, 524.5777149394773, 609.7987664070846, 629.6159342800888, 636.0840389838618, 752.6537792615349, 4931.309616653672, 5507.7246137692955, 5767.932932407434, 5859.53123750099, 6103.450689437972, 8867.600957956907, 10182.592696292213, 10486.26596138263, 10573.043986862454, 10578.994995475417, 10133.08802207805, 10535.63125290611, 10552.0, 10615.575376984989, 10650.627228046982, 8021.438499304993, 8078.515289082674, 8174.3051840593025, 8191.426600138052, 8204.425690201748, 7744.883826742716, 7846.60766961661, 7865.84268314619, 7891.487053341514, 7925.484843485155, 9095.727128186165, 9201.355905086579, 9275.86086208694, 9310.860337095084, 9434.811303774024, 9470.05299470075, 9650.0, 9682.177014953808, 9804.85292720624, 9878.85181722289, 7845.254700803414, 8101.230383113595, 8122.878156827534, 8164.959175204086, 8171.264586187272, 8091.595420228848, 8149.266566009088, 8160.795980100545, 8204.958975205085, 8222.054463736747, 6088.269407671108, 6529.347065293433, 7266.309700578437, 7357.301056399633, 7369.263073692802, 6957.8956315654295, 6990.545614535039, 7011.228764835762, 7106.395956343768, 7120.679569419285, 7469.887951680837, 7476.439267054884, 7478.177400486051, 7481.812954676177, 7560.773176804704, 6663.966680166568, 6696.7656132035145, 6710.429613482908, 6744.0, 6770.1537307836525, 6777.254502004874, 6899.206591242071, 6922.5154239202775, 6924.030635710904, 6931.445484361138], "unit": "score", "name": "mootools.html", "value": 4766.429135071639}, {"lowerIsBetter": false, "replicates": [326.7810566920163, 330.20585491892007, 333.3582853007959, 337.3001022877529, 340.7682775712515, 6888.3111688831095, 6978.2672819353875, 7024.332688394601, 7052.682629281682, 7060.894086588699, 6940.7917762467205, 6951.75668851589, 6963.860722785541, 7009.264027277139, 7014.508984371096, 5063.772130254148, 5068.594512438996, 5075.822346217892, 5093.802956305265, 5112.769925353349, 5049.697018178903, 5090.872728181788, 5092.541671249587, 5098.796048158069, 5101.311322971388, 5010.674306170105, 5014.5737612303, 5018.548330650241, 5044.117279476095, 5066.771995260204, 3845.3270677631444, 4918.2376731606655, 4980.526849949249, 5049.495050494939, 5069.873253168664, 3945.8618948336957, 4157.147784704129, 4163.208990291835, 4178.415021896906, 4185.727927684691, 5251.816186433456, 6073.787417440369, 6645.102911106987, 6654.600723956578, 6661.26726060133, 5862.560307976876, 5891.440313170242, 5906.291245050578, 5922.082077278029, 5935.10973353996, 5899.764009439617, 6260.342664020258, 7112.466565007645, 7401.296876796696, 7473.290037446434, 4510.751908645023, 4686.062787442525, 4687.578117969365, 4694.2723877799, 4718.150732868083, 7847.76456706294, 7873.763787086396, 7876.881846772303, 7891.8027049323655, 7928.405369597303, 3666.3400587894434, 4743.146233677902, 4747.643926705442, 4759.833405830779, 4782.210935195723, 3952.3676211805973, 4854.320395144682, 4861.392325959255, 4863.756812159378, 4867.853964381075, 5863.179154918314, 5873.913326034697, 5878.000739874146, 5893.499052580579, 5929.7547515022325, 7224.819379515554, 7457.962710186523, 7479.513831600929, 7479.813004674927, 7484.363829074481, 1654.4374912529797, 1677.7651128841972, 1682.3691115831564, 1684.3851994022093, 1686.0726600369749, 1001.1490233301781, 1052.289704449509, 1063.1494804156798, 1073.2809017957832, 1080.135891286983, 6803.081583986099, 6806.115205023315, 6845.110135682329, 6884.862302754017, 6909.723611055501, 7735.955645987719, 7742.8838567421535, 7749.108852482037, 7750.92249077502, 7809.414293927978, 6893.75871844483, 6916.170059592881, 6927.480438967098, 6934.549254298455, 6947.861042779116, 3754.6245375462236, 4045.3122969095325, 4060.309747342959, 4096.1193343431305, 4132.380142978577, 6625.966870165618, 8070.878936815952, 8077.232662897133, 8107.716229931924, 8209.0, 8053.033635963722, 8066.637001334954, 8070.924183287402, 8105.554194519358, 8130.227628375294, 8128.471649342892, 8133.5526546039355, 8142.999999999882, 8148.633311500997, 8153.0, 6633.6351500666, 7481.438892083007, 7572.583507907118, 7817.960910195413, 7840.686372545034, 7572.167061623107, 7626.771196864103, 7632.69469221225, 7665.885011724717, 7679.539227646359, 6523.902141467976, 8081.878771818545, 8111.269985701315, 8117.188281171835, 8121.878171827546, 4750.263709125091, 4758.666893317434, 4766.142094423037, 4770.594499467584, 4779.0, 7463.440241981982, 7753.263439973193, 7850.80372990657, 7887.250711182429, 7894.921050789649, 7503.287187717158, 7511.699532018658, 7522.736704215326, 7528.058992625922, 7561.7731468056045, 7511.549307041595, 7533.6233188339265, 7542.019537460095, 7542.509736867306, 7581.810454738455, 7005.563859408707, 7348.228436014356, 7355.1541572719825, 7361.631918403951, 7394.741184058532, 7475.850482990419, 7511.211322811245, 7518.135414427192, 7528.736494222676, 7534.513610508409, 5627.690477023803, 7176.7488137914925, 7351.228121047213, 7371.778846634609, 7385.556866588022], "unit": "score", "name": "prototype.html", "value": 5356.070210071478}, {"lowerIsBetter": false, "replicates": [644.2833461167331, 664.5766785011423, 708.5890183693458, 717.103620474407, 724.3915111306502, 14659.780103298446, 15011.024283421584, 15051.096934183957, 17055.0, 17249.91375043123, 15706.450274240375, 15742.370305187807, 15841.366345346172, 15844.28700708468, 15869.365225390999, 721.213876874207, 875.4353442029887, 878.1262643669558, 898.2723993565234, 900.8423525882977, 869.604330029838, 891.1355984694868, 893.1871996483169, 896.6278994217392, 898.7842917699737, 911.5988964855443, 932.4125800745521, 933.3280038372395, 934.9532523373838, 936.5036530638738, 822.8930239068943, 828.4366630691128, 902.251131560803, 923.796764711769, 933.0669330669331, 686.9690863911136, 689.4105539763531, 691.5297597633607, 692.4737199728193, 696.606417374182, 13185.011124165725, 14997.0, 15202.771958420633, 15217.239138043053, 15220.315085821165, 12291.938540307241, 12551.748965020648, 12560.371981400893, 12638.49446022158, 12862.163959342613, 10101.0, 10116.291859569834, 10159.847602285972, 10172.186225101974, 10178.847317290247, 3454.827258637058, 3488.0, 3490.633483484223, 3495.1087472694553, 3496.650334966483, 56809.43190568083, 72661.63669181673, 74168.88746668804, 74811.62594187049, 81886.0, 8504.277136443348, 9068.0, 9226.864408888554, 9324.25405967521, 9423.48170850596, 19892.303769368, 20003.699944500553, 20015.0, 20064.89967550182, 20074.799252007586, 7198.208197098315, 7321.450891183183, 7521.962390188014, 7550.811229719191, 7648.617569121633, 3798.3163030654746, 4100.425940368351, 4227.97886010568, 4281.12236991416, 4308.224519586442, 3478.513008178857, 3500.789952602852, 3526.3299973005046, 3531.1878267998504, 3532.6114127445962, 661.3584822721951, 662.211967758366, 662.3310456439032, 672.7409947170277, 674.0299635148976, 498.03277055629684, 583.7373182068086, 606.4208680709911, 617.8239201827547, 620.4013127332146, 8378.24595786382, 8500.857564516678, 8623.568821559022, 8635.78410539729, 8638.611262493203, 497.8954419571858, 577.8064348443235, 593.4453956055379, 612.1429998002832, 626.589583822597, 2856.571514272834, 4010.9972506873282, 4028.637422631977, 4093.774842383638, 4329.826806927687, 74561.25438745652, 78285.60857195791, 79096.20903791004, 80625.0, 83948.58025709832, 70848.64575677192, 71117.0, 71840.64079679568, 72328.63835680787, 72719.0, 62205.0, 62365.064524032176, 63590.0, 63723.36276637267, 63812.361876380644, 8689.869651955352, 8693.565321734015, 8715.259202967818, 8801.251893589117, 8937.955310223408, 38666.613333867426, 49559.0, 49580.25629615487, 49742.0, 50409.49590504048, 66040.67918641696, 66731.66536669337, 67804.0, 68702.65648671724, 69033.65483172552, 10667.573297068031, 10773.976472235125, 10852.240343175901, 11127.443627818415, 11731.296122232694, 9883.406995580288, 10723.517441715298, 10953.740319863318, 12217.266963982189, 12684.936575317064, 10763.246572740147, 11034.0, 11309.095272378354, 11460.14048946349, 12090.576829810914, 9338.346315757832, 10912.61805836792, 10978.670639880816, 11574.710632233924, 11925.880741192477, 10836.078933290759, 11397.430128493708, 11407.657770266573, 11464.31214127155, 12031.699207519881, 8907.73276801697, 9108.362414630912, 9342.486163260814, 9490.572924218288, 9711.465869377253, 8697.95651021741, 8739.344549158712, 9624.75938101553, 9727.201406198783, 9792.706218813448], "unit": "score", "name": "yui.html", "value": 6775.583662035438}], "name": "dromaeo_css", "value": 7417.513388129479}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 115.0, 114.0, 114.0, 126.0, 112.0, 113.0, 116.0, 140.0], "unit": "score", "name": "ai-astar", "value": 117.1}, {"lowerIsBetter": true, "replicates": [183.0, 121.0, 143.0, 155.0, 122.0, 146.0, 143.0, 123.0, 161.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 142.2}, {"lowerIsBetter": true, "replicates": [193.0, 196.0, 201.0, 203.0, 205.0, 223.0, 242.0, 272.0, 207.0, 199.0], "unit": "score", "name": "audio-dft", "value": 214.1}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 71.0, 104.0, 55.0, 57.0, 61.0, 58.0, 107.0, 58.0], "unit": "score", "name": "audio-fft", "value": 71.1}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 121.0, 80.0, 81.0, 83.0, 114.0, 79.0, 80.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 91.8}, {"lowerIsBetter": true, "replicates": [86.0, 95.0, 87.0, 92.0, 86.0, 93.0, 86.0, 93.0, 87.0, 95.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.0}, {"lowerIsBetter": true, "replicates": [112.0, 96.0, 94.0, 95.0, 96.0, 108.0, 95.0, 102.0, 155.0, 156.0], "unit": "score", "name": "imaging-darkroom", "value": 110.9}, {"lowerIsBetter": true, "replicates": [146.0, 132.0, 90.0, 88.0, 135.0, 144.0, 148.0, 91.0, 131.0, 150.0], "unit": "score", "name": "imaging-desaturate", "value": 125.5}, {"lowerIsBetter": true, "replicates": [54.0, 56.0, 52.0, 62.0, 67.0, 51.0, 50.0, 72.0, 87.0, 87.0], "unit": "score", "name": "json-parse-financial", "value": 63.8}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 82.0, 89.0, 61.0, 90.0, 102.0, 98.0, 91.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 80.7}, {"lowerIsBetter": true, "replicates": [89.0, 86.0, 84.0, 86.0, 85.0, 86.0, 86.0, 86.0, 88.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [124.0, 127.0, 128.0, 134.0, 124.0, 131.0, 141.0, 136.0, 119.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.9}, {"lowerIsBetter": true, "replicates": [138.0, 140.0, 139.0, 141.0, 144.0, 180.0, 132.0, 144.0, 143.0, 128.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.9}, {"lowerIsBetter": true, "replicates": [56.0, 89.0, 97.0, 96.0, 63.0, 87.0, 98.0, 97.0, 99.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 85.4}], "name": "kraken", "value": 1550.6000000000004}]} 17:32:13 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1550.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7417.51"}}} 17:32:13 INFO - Return code: 0 17:32:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:32:13 ERROR - # TBPL SUCCESS # 17:32:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:32:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:32:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:32:13 INFO - 2016-02-24 17:32:13.125 screenresolution[1697:10401] starting screenresolution argv=screenresolution get 17:32:13 INFO - 2016-02-24 17:32:13.128 screenresolution[1697:10401] Display 0: 1600x1200x32@60 17:32:13 INFO - 2016-02-24 17:32:13.134 screenresolution[1698:10404] starting screenresolution argv=screenresolution list 17:32:13 INFO - Available Modes on Display 0 17:32:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:32:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:32:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:32:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:32:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:32:13 INFO - Intel Iris: 17:32:13 INFO - Chipset Model: Intel Iris 17:32:13 INFO - Type: GPU 17:32:13 INFO - Bus: Built-In 17:32:13 INFO - VRAM (Dynamic, Max): 1536 MB 17:32:13 INFO - Vendor: Intel (0x8086) 17:32:13 INFO - Device ID: 0x0a2e 17:32:13 INFO - Revision ID: 0x0009 17:32:13 INFO - Displays: 17:32:13 INFO - Display: 17:32:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:32:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:32:13 INFO - Display Serial Number: 1600x1200 60 17:32:13 INFO - Main Display: Yes 17:32:13 INFO - Mirror: Off 17:32:13 INFO - Online: Yes 17:32:13 INFO - Rotation: Supported 17:32:13 INFO - Return code: 0 17:32:13 INFO - Running post-action listener: _resource_record_post_action 17:32:13 INFO - Running post-run listener: _resource_record_post_run 17:32:14 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 39478784; Write bytes: 712817152; Read time: 507; Write time: 2537 17:32:14 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 389147136; Write bytes: 383834112; Read time: 30556; Write time: 1237 17:32:14 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 38516224; Write bytes: 305676800; Read time: 410; Write time: 1250 17:32:14 INFO - Running post-run listener: _upload_blobber_files 17:32:14 INFO - Blob upload gear active. 17:32:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:32:14 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 17:32:14 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'] 17:32:14 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 17:32:14 INFO - (blobuploader) - INFO - Open directory for files ... 17:32:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:32:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:32:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:15 INFO - (blobuploader) - INFO - Done attempting. 17:32:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:32:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:32:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:16 INFO - (blobuploader) - INFO - Done attempting. 17:32:16 INFO - (blobuploader) - INFO - Iteration through files over. 17:32:16 INFO - Return code: 0 17:32:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:32:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:32:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d69363fd3c59dcb9783f99286d6b6079ad882ae27ed8483214f7a8ed7fca5d1ee86766beea021d08e0b09848cb93de983bbb00a5c58b2539e13f14b05d88e00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71e5ef89c37df32a07098f56f0efe53ccfee2c8f4ad026d279274f50b6aadd2ffd435ef3879a0d578c790f8bccaeb1650f1f32cc6b63b1549892ed6e4c6d0035"} 17:32:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:32:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:32:16 INFO - Contents: 17:32:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d69363fd3c59dcb9783f99286d6b6079ad882ae27ed8483214f7a8ed7fca5d1ee86766beea021d08e0b09848cb93de983bbb00a5c58b2539e13f14b05d88e00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71e5ef89c37df32a07098f56f0efe53ccfee2c8f4ad026d279274f50b6aadd2ffd435ef3879a0d578c790f8bccaeb1650f1f32cc6b63b1549892ed6e4c6d0035"} 17:32:16 INFO - Running post-run listener: copy_logs_to_upload_dir 17:32:16 INFO - Copying logs to upload dir... 17:32:16 INFO - mkdir: /builds/slave/test/build/upload/logs 17:32:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.563086 ========= master_lag: 2.86 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-02-24 17:32:19.380479) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-02-24 17:32:19.388358) ========= 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.iyvGqbGBhc/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.P5Pcb3d54R/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d69363fd3c59dcb9783f99286d6b6079ad882ae27ed8483214f7a8ed7fca5d1ee86766beea021d08e0b09848cb93de983bbb00a5c58b2539e13f14b05d88e00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71e5ef89c37df32a07098f56f0efe53ccfee2c8f4ad026d279274f50b6aadd2ffd435ef3879a0d578c790f8bccaeb1650f1f32cc6b63b1549892ed6e4c6d0035"} build_url:https://queue.taskcluster.net/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011389 build_url: 'https://queue.taskcluster.net/v1/task/ZZVxKVXUQ_OMdXWXv2ZE4Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d69363fd3c59dcb9783f99286d6b6079ad882ae27ed8483214f7a8ed7fca5d1ee86766beea021d08e0b09848cb93de983bbb00a5c58b2539e13f14b05d88e00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71e5ef89c37df32a07098f56f0efe53ccfee2c8f4ad026d279274f50b6aadd2ffd435ef3879a0d578c790f8bccaeb1650f1f32cc6b63b1549892ed6e4c6d0035"}' ========= master_lag: 1.53 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-02-24 17:32:20.929439) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 17:32:20.929834) ========= 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.iyvGqbGBhc/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.P5Pcb3d54R/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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.005055 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 17:32:20.956904) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 17:32:20.957261) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 17:32:20.958602) ========= ========= Total master_lag: 4.96 =========