builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0092 starttime: 1457918612.34 results: success (0) buildid: 20160313160931 builduid: 316dbd5f9070405093fa9f262c3d3d3f revision: f0c0480732d36153e8839c7f17394d45f679f87d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-13 18:23:32.345147) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-13 18:23:32.345593) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-13 18:23:32.345888) ========= 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.y1MUSjYWWI/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.8t8q8pVwII/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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.005813 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-13 18:23:32.369119) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-13 18:23:32.369453) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-13 18:23:32.385622) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 18:23:32.385888) ========= 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.y1MUSjYWWI/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.8t8q8pVwII/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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.005344 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 18:23:32.434060) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-13 18:23:32.434352) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-13 18:23:32.434718) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 18:23:32.435000) ========= 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.y1MUSjYWWI/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.8t8q8pVwII/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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-03-13 18:23:32-- 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% 20.9M=0.001s 2016-03-13 18:23:32 (20.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157867 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 18:23:32.608978) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 18:23:32.609292) ========= 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.y1MUSjYWWI/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.8t8q8pVwII/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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.019595 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 18:23:32.657752) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-13 18:23:32.658104) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f0c0480732d36153e8839c7f17394d45f679f87d --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 f0c0480732d36153e8839c7f17394d45f679f87d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.y1MUSjYWWI/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.8t8q8pVwII/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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-03-13 18:23:32,731 truncating revision to first 12 chars 2016-03-13 18:23:32,731 Setting DEBUG logging. 2016-03-13 18:23:32,731 attempt 1/10 2016-03-13 18:23:32,731 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f0c0480732d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-13 18:23:33,931 unpacking tar archive at: mozilla-central-f0c0480732d3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.452418 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-13 18:23:34.127327) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-13 18:23:34.127679) ========= echo f0c0480732d36153e8839c7f17394d45f679f87d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f0c0480732d36153e8839c7f17394d45f679f87d'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.y1MUSjYWWI/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.8t8q8pVwII/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 f0c0480732d36153e8839c7f17394d45f679f87d program finished with exit code 0 elapsedTime=0.005001 script_repo_revision: 'f0c0480732d36153e8839c7f17394d45f679f87d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-13 18:23:34.177696) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-13 18:23:34.178018) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-13 18:23:34.191832) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-03-13 18:23:34.192241) ========= /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.y1MUSjYWWI/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.8t8q8pVwII/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 18:23:34 INFO - MultiFileLogger online at 20160313 18:23:34 in /builds/slave/test 18:23:34 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 18:23:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:23:34 INFO - {'append_to_log': False, 18:23:34 INFO - 'base_work_dir': '/builds/slave/test', 18:23:34 INFO - 'blob_upload_branch': 'Firefox', 18:23:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:23:34 INFO - 'branch': 'Firefox', 18:23:34 INFO - 'buildbot_json_path': 'buildprops.json', 18:23:34 INFO - 'config_files': ('talos/mac_config.py',), 18:23:34 INFO - 'default_actions': ('clobber', 18:23:34 INFO - 'read-buildbot-config', 18:23:34 INFO - 'download-and-extract', 18:23:34 INFO - 'populate-webroot', 18:23:34 INFO - 'create-virtualenv', 18:23:34 INFO - 'install', 18:23:34 INFO - 'run-tests'), 18:23:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:23:34 INFO - 'download_minidump_stackwalk': True, 18:23:34 INFO - 'download_symbols': 'ondemand', 18:23:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:23:34 INFO - 'tooltool.py': '/tools/tooltool.py', 18:23:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:23:34 INFO - '/tools/misc-python/virtualenv.py')}, 18:23:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:23:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:23:34 INFO - 'installer_path': 'installer.exe', 18:23:34 INFO - 'log_level': 'info', 18:23:34 INFO - 'log_name': 'talos', 18:23:34 INFO - 'log_to_console': True, 18:23:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:23:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:23:34 INFO - 'opt_config_files': (), 18:23:34 INFO - 'pip_index': False, 18:23:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:23:34 INFO - 'cmd': ('bash', 18:23:34 INFO - '-c', 18:23:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:23:34 INFO - 'enabled': True, 18:23:34 INFO - 'halt_on_failure': False, 18:23:34 INFO - 'name': 'check_screen_resolution'},), 18:23:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:23:34 INFO - 'cmd': ('bash', 18:23:34 INFO - '-c', 18:23:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:23:34 INFO - 'enabled': True, 18:23:34 INFO - 'halt_on_failure': False, 18:23:34 INFO - 'name': 'check_screen_resolution'},), 18:23:34 INFO - 'run_cmd_checks_enabled': True, 18:23:34 INFO - 'sps_profile': False, 18:23:34 INFO - 'sps_profile_interval': 0, 18:23:34 INFO - 'suite': 'dromaeojs-e10s', 18:23:34 INFO - 'system_bits': '32', 18:23:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:23:34 INFO - 'title': 't-yosemite-r7-0092', 18:23:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:23:34 INFO - 'use_talos_json': True, 18:23:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:23:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:23:34 INFO - 'work_dir': 'build'} 18:23:34 INFO - ##### 18:23:34 INFO - ##### Running clobber step. 18:23:34 INFO - ##### 18:23:34 INFO - Running pre-action listener: _resource_record_pre_action 18:23:34 INFO - Running main action method: clobber 18:23:34 INFO - rmtree: /builds/slave/test/build 18:23:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:23:35 INFO - Running post-action listener: _resource_record_post_action 18:23:35 INFO - ##### 18:23:35 INFO - ##### Running read-buildbot-config step. 18:23:35 INFO - ##### 18:23:35 INFO - Running pre-action listener: _resource_record_pre_action 18:23:35 INFO - Running main action method: read_buildbot_config 18:23:35 INFO - Using buildbot properties: 18:23:35 INFO - { 18:23:35 INFO - "project": "", 18:23:35 INFO - "product": "firefox", 18:23:35 INFO - "script_repo_revision": "production", 18:23:35 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 18:23:35 INFO - "repository": "", 18:23:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 18:23:35 INFO - "buildid": "20160313160931", 18:23:35 INFO - "pgo_build": "False", 18:23:35 INFO - "basedir": "/builds/slave/test", 18:23:35 INFO - "buildnumber": 189, 18:23:35 INFO - "slavename": "t-yosemite-r7-0092", 18:23:35 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:23:35 INFO - "platform": "yosemite_r7", 18:23:35 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:23:35 INFO - "branch": "mozilla-central", 18:23:35 INFO - "repo_path": "mozilla-central", 18:23:35 INFO - "revision": "f0c0480732d36153e8839c7f17394d45f679f87d", 18:23:35 INFO - "stage_platform": "macosx64", 18:23:35 INFO - "builduid": "316dbd5f9070405093fa9f262c3d3d3f", 18:23:35 INFO - "slavebuilddir": "test" 18:23:35 INFO - } 18:23:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 18:23:35 INFO - Running post-action listener: _resource_record_post_action 18:23:35 INFO - ##### 18:23:35 INFO - ##### Running download-and-extract step. 18:23:35 INFO - ##### 18:23:35 INFO - Running pre-action listener: _resource_record_pre_action 18:23:35 INFO - Running main action method: download_and_extract 18:23:35 INFO - mkdir: /builds/slave/test/build/tests 18:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:35 INFO - https://queue.taskcluster.net/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:23:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:23:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:23:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 18:23:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 18:23:37 INFO - Downloaded 1199 bytes. 18:23:37 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 18:23:37 INFO - Using the following test package requirements: 18:23:37 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:23:37 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:23:37 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 18:23:37 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:23:37 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 18:23:37 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:23:37 INFO - u'jsshell-mac.zip'], 18:23:37 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:23:37 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 18:23:37 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:23:37 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:23:37 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 18:23:37 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:23:37 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 18:23:37 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:23:37 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 18:23:37 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:23:37 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 18:23:37 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:37 INFO - https://queue.taskcluster.net/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:23:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:23:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:23:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:23:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:23:38 INFO - Downloaded 17850706 bytes. 18:23:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:23:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:23:41 INFO - Return code: 0 18:23:41 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:23: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')]} 18:23:41 INFO - https://queue.taskcluster.net/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:23:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:23:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:23:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:23:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:23:42 INFO - Downloaded 17850706 bytes. 18:23:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:23:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:23:45 INFO - Return code: 0 18:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:45 INFO - https://queue.taskcluster.net/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:23:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:23:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:23:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:23:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:23:46 INFO - Downloaded 10845263 bytes. 18:23:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:23:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 18:23:47 INFO - Return code: 0 18:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:47 INFO - https://queue.taskcluster.net/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:23:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:23:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:23:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 18:23:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 18:23:50 INFO - Downloaded 111202305 bytes. 18:23:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:23:50 INFO - mkdir: /builds/slave/test/properties 18:23:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:23:50 INFO - Writing to file /builds/slave/test/properties/build_url 18:23:50 INFO - Contents: 18:23:50 INFO - build_url:https://queue.taskcluster.net/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:23:51 INFO - Running post-action listener: _resource_record_post_action 18:23:51 INFO - Running post-action listener: set_extra_try_arguments 18:23:51 INFO - ##### 18:23:51 INFO - ##### Running populate-webroot step. 18:23:51 INFO - ##### 18:23:51 INFO - Running pre-action listener: _resource_record_pre_action 18:23:51 INFO - Running main action method: populate_webroot 18:23:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:23:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:23:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:23:51 INFO - '--tppagecycles', 18:23:51 INFO - '7'], 18:23:51 INFO - 'tests': ['tsvgm']}}, 18:23:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:23:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:23:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:23:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:23:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:23:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:23:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:23:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:51 INFO - 'talos_options': ['--e10s'], 18:23:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:23:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:51 INFO - 'tests': ['damp', 'tps']}, 18:23:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:51 INFO - 'talos_options': ['--e10s'], 18:23:51 INFO - 'tests': ['damp', 'tps']}, 18:23:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:23:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:23:51 INFO - 'other': {'tests': ['a11yr', 18:23:51 INFO - 'ts_paint', 18:23:51 INFO - 'tpaint', 18:23:51 INFO - 'sessionrestore', 18:23:51 INFO - 'sessionrestore_no_auto_restore', 18:23:51 INFO - 'tabpaint']}, 18:23:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:23:51 INFO - 'tests': ['a11yr', 18:23:51 INFO - 'ts_paint', 18:23:51 INFO - 'tpaint', 18:23:51 INFO - 'sessionrestore', 18:23:51 INFO - 'sessionrestore_no_auto_restore', 18:23:51 INFO - 'tabpaint']}, 18:23:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:23:51 INFO - 'tests': ['a11yr', 18:23:51 INFO - 'ts_paint', 18:23:51 INFO - 'tpaint', 18:23:51 INFO - 'sessionrestore', 18:23:51 INFO - 'sessionrestore_no_auto_restore', 18:23:51 INFO - 'tabpaint']}, 18:23:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:23:51 INFO - 'tests': ['a11yr', 18:23:51 INFO - 'ts_paint', 18:23:51 INFO - 'tpaint', 18:23:51 INFO - 'sessionrestore', 18:23:51 INFO - 'sessionrestore_no_auto_restore', 18:23:51 INFO - 'tabpaint']}, 18:23:51 INFO - 'other_l64': {'tests': ['a11yr', 18:23:51 INFO - 'ts_paint', 18:23:51 INFO - 'tpaint', 18:23:51 INFO - 'sessionrestore', 18:23:51 INFO - 'sessionrestore_no_auto_restore', 18:23:51 INFO - 'tabpaint']}, 18:23:51 INFO - 'other_nol64': {'tests': ['a11yr', 18:23:51 INFO - 'ts_paint', 18:23:51 INFO - 'tpaint', 18:23:51 INFO - 'sessionrestore', 18:23:51 INFO - 'sessionrestore_no_auto_restore', 18:23:51 INFO - 'tabpaint']}, 18:23:51 INFO - 'svgr': {'tests': ['tsvgx', 18:23:51 INFO - 'tsvgr_opacity', 18:23:51 INFO - 'tart', 18:23:51 INFO - 'tscrollx', 18:23:51 INFO - 'cart']}, 18:23:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:23:51 INFO - 'tests': ['tsvgx', 18:23:51 INFO - 'tsvgr_opacity', 18:23:51 INFO - 'tart', 18:23:51 INFO - 'tscrollx', 18:23:51 INFO - 'cart']}, 18:23:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:51 INFO - 'tests': ['tp5o']}, 18:23:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:51 INFO - 'talos_options': ['--e10s'], 18:23:51 INFO - 'tests': ['tp5o']}, 18:23:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:51 INFO - 'talos_options': ['--xperf_path', 18:23:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:23:51 INFO - 'tests': ['tp5n']}, 18:23:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:51 INFO - 'talos_options': ['--e10s', 18:23:51 INFO - '--xperf_path', 18:23:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:23:51 INFO - 'tests': ['tp5n']}}, 18:23:51 INFO - 'talos.zip': {'path': '', 18:23:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:23:51 INFO - Running post-action listener: _resource_record_post_action 18:23:51 INFO - ##### 18:23:51 INFO - ##### Running create-virtualenv step. 18:23:51 INFO - ##### 18:23:51 INFO - Running pre-action listener: _resource_record_pre_action 18:23:51 INFO - Running main action method: create_virtualenv 18:23:51 INFO - Creating virtualenv /builds/slave/test/build/venv 18:23:51 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 18:23:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:23:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:23:51 INFO - Using real prefix '/tools/python27' 18:23:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:23:52 INFO - Installing distribute.............................................................................................................................................................................................done. 18:23:55 INFO - Installing pip.................done. 18:23:55 INFO - Return code: 0 18:23:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:23: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')]} 18:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23: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')]} 18:23:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1102c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ce8c9b190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110167d30>, '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 0x10ff8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11015eb20>, '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.y1MUSjYWWI/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.8t8q8pVwII/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 18:23: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', 'pip>=1.5'] in /builds/slave/test/build 18:23: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 pip>=1.5 18:23:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y1MUSjYWWI/Render', 18:23:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:55 INFO - 'HOME': '/Users/cltbld', 18:23:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:55 INFO - 'LOGNAME': 'cltbld', 18:23:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:55 INFO - 'MOZ_NO_REMOTE': '1', 18:23:55 INFO - 'NO_EM_RESTART': '1', 18:23:55 INFO - 'PAGER': '/bin/cat', 18:23:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:55 INFO - 'PWD': '/builds/slave/test', 18:23:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:55 INFO - 'SHELL': '/bin/bash', 18:23:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8t8q8pVwII/Listeners', 18:23:55 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 18:23:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:55 INFO - 'USER': 'cltbld', 18:23:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:55 INFO - 'XPC_FLAGS': '0x0', 18:23:55 INFO - 'XPC_SERVICE_NAME': '0', 18:23:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:55 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 18:23:55 INFO - Cleaning up... 18:23:55 INFO - Return code: 0 18:23:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:23: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')]} 18:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23: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')]} 18:23:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23: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', '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 0x1102c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ce8c9b190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110167d30>, '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 0x10ff8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11015eb20>, '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.y1MUSjYWWI/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.8t8q8pVwII/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 18:23: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', 'psutil>=0.7.1'] in /builds/slave/test/build 18:23: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 psutil>=0.7.1 18:23:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y1MUSjYWWI/Render', 18:23:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:55 INFO - 'HOME': '/Users/cltbld', 18:23:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:55 INFO - 'LOGNAME': 'cltbld', 18:23:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:55 INFO - 'MOZ_NO_REMOTE': '1', 18:23:55 INFO - 'NO_EM_RESTART': '1', 18:23:55 INFO - 'PAGER': '/bin/cat', 18:23:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:55 INFO - 'PWD': '/builds/slave/test', 18:23:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:55 INFO - 'SHELL': '/bin/bash', 18:23:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8t8q8pVwII/Listeners', 18:23:55 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 18:23:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:55 INFO - 'USER': 'cltbld', 18:23:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:55 INFO - 'XPC_FLAGS': '0x0', 18:23:55 INFO - 'XPC_SERVICE_NAME': '0', 18:23:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:56 INFO - Downloading/unpacking psutil>=0.7.1 18:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:23:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:23:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:23:59 INFO - Installing collected packages: psutil 18:23:59 INFO - Running setup.py install for psutil 18:23:59 INFO - building 'psutil._psutil_osx' extension 18:23:59 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 18:23:59 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 18:23:59 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 18:23:59 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 18:23:59 INFO - building 'psutil._psutil_posix' extension 18:23:59 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 18:23:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:23:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:23:59 INFO - ^ 18:23:59 INFO - 1 warning generated. 18:23:59 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 18:23:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:23:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:23:59 INFO - Successfully installed psutil 18:23:59 INFO - Cleaning up... 18:23:59 INFO - Return code: 0 18:23:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:59 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 0x1102c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ce8c9b190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110167d30>, '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 0x10ff8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11015eb20>, '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.y1MUSjYWWI/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.8t8q8pVwII/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 18:23:59 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 18:23:59 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 18:23:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y1MUSjYWWI/Render', 18:23:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:59 INFO - 'HOME': '/Users/cltbld', 18:23:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:59 INFO - 'LOGNAME': 'cltbld', 18:23:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:59 INFO - 'MOZ_NO_REMOTE': '1', 18:23:59 INFO - 'NO_EM_RESTART': '1', 18:23:59 INFO - 'PAGER': '/bin/cat', 18:23:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:59 INFO - 'PWD': '/builds/slave/test', 18:23:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:59 INFO - 'SHELL': '/bin/bash', 18:23:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8t8q8pVwII/Listeners', 18:23:59 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 18:23:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:59 INFO - 'USER': 'cltbld', 18:23:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:59 INFO - 'XPC_FLAGS': '0x0', 18:23:59 INFO - 'XPC_SERVICE_NAME': '0', 18:23:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:24:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:24:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:24:02 INFO - Installing collected packages: mozsystemmonitor 18:24:02 INFO - Running setup.py install for mozsystemmonitor 18:24:02 INFO - Successfully installed mozsystemmonitor 18:24:02 INFO - Cleaning up... 18:24:02 INFO - Return code: 0 18:24:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:02 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 0x1102c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ce8c9b190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110167d30>, '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 0x10ff8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11015eb20>, '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.y1MUSjYWWI/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.8t8q8pVwII/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 18:24:02 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 18:24:02 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 18:24:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y1MUSjYWWI/Render', 18:24:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:02 INFO - 'HOME': '/Users/cltbld', 18:24:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:02 INFO - 'LOGNAME': 'cltbld', 18:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:02 INFO - 'MOZ_NO_REMOTE': '1', 18:24:02 INFO - 'NO_EM_RESTART': '1', 18:24:02 INFO - 'PAGER': '/bin/cat', 18:24:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:02 INFO - 'PWD': '/builds/slave/test', 18:24:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:02 INFO - 'SHELL': '/bin/bash', 18:24:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8t8q8pVwII/Listeners', 18:24:02 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 18:24:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:02 INFO - 'USER': 'cltbld', 18:24:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:02 INFO - 'XPC_FLAGS': '0x0', 18:24:02 INFO - 'XPC_SERVICE_NAME': '0', 18:24:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:03 INFO - Downloading/unpacking blobuploader==1.2.4 18:24:03 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 18:24:03 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 18:24:03 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 18:24:03 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 18:24:03 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 18:24:03 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 18:24:05 INFO - Downloading blobuploader-1.2.4.tar.gz 18:24:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:24:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:24:05 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 18:24:05 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 18:24:05 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 18:24:05 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 18:24:05 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 18:24:05 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 18:24:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:24:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:06 INFO - Downloading docopt-0.6.1.tar.gz 18:24:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:24:06 INFO - Installing collected packages: blobuploader, requests, docopt 18:24:06 INFO - Running setup.py install for blobuploader 18:24:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:24:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:24:06 INFO - Running setup.py install for requests 18:24:07 INFO - Running setup.py install for docopt 18:24:07 INFO - Successfully installed blobuploader requests docopt 18:24:07 INFO - Cleaning up... 18:24:07 INFO - Return code: 0 18:24:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:24:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:07 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 0x1102c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ce8c9b190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110167d30>, '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 0x10ff8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11015eb20>, '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.y1MUSjYWWI/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.8t8q8pVwII/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 18:24:07 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 18:24:07 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 18:24:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y1MUSjYWWI/Render', 18:24:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:07 INFO - 'HOME': '/Users/cltbld', 18:24:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:07 INFO - 'LOGNAME': 'cltbld', 18:24:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:07 INFO - 'MOZ_NO_REMOTE': '1', 18:24:07 INFO - 'NO_EM_RESTART': '1', 18:24:07 INFO - 'PAGER': '/bin/cat', 18:24:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:07 INFO - 'PWD': '/builds/slave/test', 18:24:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:07 INFO - 'SHELL': '/bin/bash', 18:24:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8t8q8pVwII/Listeners', 18:24:07 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 18:24:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:07 INFO - 'USER': 'cltbld', 18:24:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:07 INFO - 'XPC_FLAGS': '0x0', 18:24:07 INFO - 'XPC_SERVICE_NAME': '0', 18:24:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:24:07 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-AxhKyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:24:07 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-vztPU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:24:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-2gKK2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:24:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-INHSE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:24:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-GomA1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:24:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-bKHEPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:24:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-brBg7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:24:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-Y7ABp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:24:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-HvAvQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:24:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-9j1Oj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:24:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-YCILH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:24:08 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-jr5qjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:24:09 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-N3mxab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:24:09 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-MoHoSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:24:09 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-D4aqGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:24:09 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-sN0a4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:24:09 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-KIq1QR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:24:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:24:09 INFO - Running setup.py install for manifestparser 18:24:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:24:09 INFO - Running setup.py install for mozcrash 18:24:09 INFO - Running setup.py install for mozdebug 18:24:09 INFO - Running setup.py install for mozdevice 18:24:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:24:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:24:10 INFO - Running setup.py install for mozfile 18:24:10 INFO - Running setup.py install for mozhttpd 18:24:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:24:10 INFO - Running setup.py install for mozinfo 18:24:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:24:10 INFO - Running setup.py install for mozInstall 18:24:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:24:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:24:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:24:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:24:10 INFO - Running setup.py install for mozleak 18:24:10 INFO - Running setup.py install for mozlog 18:24:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:24:11 INFO - Running setup.py install for moznetwork 18:24:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:24:11 INFO - Running setup.py install for mozprocess 18:24:11 INFO - Running setup.py install for mozprofile 18:24:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:24:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:24:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:24:11 INFO - Running setup.py install for mozrunner 18:24:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:24:11 INFO - Running setup.py install for mozscreenshot 18:24:11 INFO - Running setup.py install for moztest 18:24:11 INFO - Running setup.py install for mozversion 18:24:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:24:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:24:12 INFO - Cleaning up... 18:24:12 INFO - Return code: 0 18:24:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:12 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 0x1102c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ce8c9b190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110167d30>, '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 0x10ff8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11015eb20>, '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.y1MUSjYWWI/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.8t8q8pVwII/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 18:24:12 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 18:24:12 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 18:24:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y1MUSjYWWI/Render', 18:24:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:12 INFO - 'HOME': '/Users/cltbld', 18:24:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:12 INFO - 'LOGNAME': 'cltbld', 18:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:12 INFO - 'MOZ_NO_REMOTE': '1', 18:24:12 INFO - 'NO_EM_RESTART': '1', 18:24:12 INFO - 'PAGER': '/bin/cat', 18:24:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:12 INFO - 'PWD': '/builds/slave/test', 18:24:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:12 INFO - 'SHELL': '/bin/bash', 18:24:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8t8q8pVwII/Listeners', 18:24:12 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 18:24:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:12 INFO - 'USER': 'cltbld', 18:24:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:12 INFO - 'XPC_FLAGS': '0x0', 18:24:12 INFO - 'XPC_SERVICE_NAME': '0', 18:24:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:24:12 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-kEAnyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:24:12 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)) 18:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:24:12 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-zSCmJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 18:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:24:12 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-juQtFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:24:12 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)) 18:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:24:12 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-Xb8vBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:24:12 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)) 18:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:24:12 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-6wx_eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:24:12 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)) 18:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:24:12 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-1ERikb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:24:13 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)) 18:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:24:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-Lb4kiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:24:13 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)) 18:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:24:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-SdUlVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:24:13 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)) 18:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:24:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-eEJpU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:24:13 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)) 18:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:24:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-FfDfOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:24:13 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)) 18:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:24:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-Dl13Yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:24:13 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)) 18:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:24:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-ZVNPE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:24:13 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)) 18:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:24:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-2Ulk6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:24:13 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)) 18:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:24:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-qdPwo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:24:13 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)) 18:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:24:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-paas2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:24:13 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)) 18:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:24:13 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-xUeUUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:24:14 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)) 18:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:24:14 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-5amdgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:24:14 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)) 18:24:14 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:24:14 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:24:14 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)) 18:24:14 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)) 18:24:14 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)) 18:24:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:24:14 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 18:24:14 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 18:24:14 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 18:24:14 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 18:24:14 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 18:24:14 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 18:24:16 INFO - Downloading blessings-1.6.tar.gz 18:24:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:24:16 INFO - Installing collected packages: blessings 18:24:16 INFO - Running setup.py install for blessings 18:24:16 INFO - Successfully installed blessings 18:24:16 INFO - Cleaning up... 18:24:16 INFO - Return code: 0 18:24:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:24:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:24:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:24:17 INFO - Reading from file tmpfile_stdout 18:24:17 INFO - Current package versions: 18:24:17 INFO - blessings == 1.6 18:24:17 INFO - blobuploader == 1.2.4 18:24:17 INFO - docopt == 0.6.1 18:24:17 INFO - manifestparser == 1.1 18:24:17 INFO - mozInstall == 1.12 18:24:17 INFO - mozcrash == 0.17 18:24:17 INFO - mozdebug == 0.1 18:24:17 INFO - mozdevice == 0.48 18:24:17 INFO - mozfile == 1.2 18:24:17 INFO - mozhttpd == 0.7 18:24:17 INFO - mozinfo == 0.9 18:24:17 INFO - mozleak == 0.1 18:24:17 INFO - mozlog == 3.1 18:24:17 INFO - moznetwork == 0.27 18:24:17 INFO - mozprocess == 0.22 18:24:17 INFO - mozprofile == 0.28 18:24:17 INFO - mozrunner == 6.11 18:24:17 INFO - mozscreenshot == 0.1 18:24:17 INFO - mozsystemmonitor == 0.0 18:24:17 INFO - moztest == 0.7 18:24:17 INFO - mozversion == 1.4 18:24:17 INFO - psutil == 3.1.1 18:24:17 INFO - requests == 1.2.3 18:24:17 INFO - wsgiref == 0.1.2 18:24:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:17 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 0x1102c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ce8c9b190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110167d30>, '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 0x10ff8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11015eb20>, '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.y1MUSjYWWI/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.8t8q8pVwII/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 18:24:17 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 18:24:17 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 18:24:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y1MUSjYWWI/Render', 18:24:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:17 INFO - 'HOME': '/Users/cltbld', 18:24:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:17 INFO - 'LOGNAME': 'cltbld', 18:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:17 INFO - 'MOZ_NO_REMOTE': '1', 18:24:17 INFO - 'NO_EM_RESTART': '1', 18:24:17 INFO - 'PAGER': '/bin/cat', 18:24:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:17 INFO - 'PWD': '/builds/slave/test', 18:24:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:17 INFO - 'SHELL': '/bin/bash', 18:24:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8t8q8pVwII/Listeners', 18:24:17 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 18:24:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:17 INFO - 'USER': 'cltbld', 18:24:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:17 INFO - 'XPC_FLAGS': '0x0', 18:24:17 INFO - 'XPC_SERVICE_NAME': '0', 18:24:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:17 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)) 18:24:17 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)) 18:24:17 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)) 18:24:17 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)) 18:24:17 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)) 18:24:17 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)) 18:24:17 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)) 18:24:17 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)) 18:24:17 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)) 18:24:17 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)) 18:24:17 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)) 18:24:17 INFO - Cleaning up... 18:24:17 INFO - Return code: 0 18:24:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:17 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 0x1102c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ce8c9b190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110167d30>, '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 0x10ff8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11015eb20>, '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.y1MUSjYWWI/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.8t8q8pVwII/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 18:24:17 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 18:24:17 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 18:24:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y1MUSjYWWI/Render', 18:24:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:17 INFO - 'HOME': '/Users/cltbld', 18:24:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:17 INFO - 'LOGNAME': 'cltbld', 18:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:17 INFO - 'MOZ_NO_REMOTE': '1', 18:24:17 INFO - 'NO_EM_RESTART': '1', 18:24:17 INFO - 'PAGER': '/bin/cat', 18:24:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:17 INFO - 'PWD': '/builds/slave/test', 18:24:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:17 INFO - 'SHELL': '/bin/bash', 18:24:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8t8q8pVwII/Listeners', 18:24:17 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 18:24:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:17 INFO - 'USER': 'cltbld', 18:24:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:17 INFO - 'XPC_FLAGS': '0x0', 18:24:17 INFO - 'XPC_SERVICE_NAME': '0', 18:24:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:17 INFO - Downloading/unpacking jsonschema 18:24:17 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 18:24:17 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 18:24:17 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 18:24:17 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 18:24:17 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 18:24:17 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 18:24:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:24:19 INFO - Downloading/unpacking functools32 (from jsonschema) 18:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:20 INFO - Downloading functools32-3.2.3-2.tar.gz 18:24:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:24:20 INFO - warning: no files found matching '*.txt' 18:24:20 INFO - no previously-included directories found matching 'build' 18:24:20 INFO - no previously-included directories found matching 'dist' 18:24:20 INFO - no previously-included directories found matching '.git*' 18:24:20 INFO - Installing collected packages: jsonschema, functools32 18:24:20 INFO - Running setup.py install for functools32 18:24:20 INFO - warning: no files found matching '*.txt' 18:24:20 INFO - no previously-included directories found matching 'build' 18:24:20 INFO - no previously-included directories found matching 'dist' 18:24:20 INFO - no previously-included directories found matching '.git*' 18:24:20 INFO - Successfully installed jsonschema functools32 18:24:20 INFO - Cleaning up... 18:24:20 INFO - Return code: 0 18:24:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:24: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')]} 18:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24: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')]} 18:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:20 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 0x1102c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ce8c9b190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110167d30>, '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 0x10ff8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11015eb20>, '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.y1MUSjYWWI/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.8t8q8pVwII/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 18:24:20 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 18:24:20 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 18:24:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y1MUSjYWWI/Render', 18:24:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:20 INFO - 'HOME': '/Users/cltbld', 18:24:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:20 INFO - 'LOGNAME': 'cltbld', 18:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:20 INFO - 'MOZ_NO_REMOTE': '1', 18:24:20 INFO - 'NO_EM_RESTART': '1', 18:24:20 INFO - 'PAGER': '/bin/cat', 18:24:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:20 INFO - 'PWD': '/builds/slave/test', 18:24:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:20 INFO - 'SHELL': '/bin/bash', 18:24:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8t8q8pVwII/Listeners', 18:24:20 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 18:24:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:20 INFO - 'USER': 'cltbld', 18:24:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:20 INFO - 'XPC_FLAGS': '0x0', 18:24:20 INFO - 'XPC_SERVICE_NAME': '0', 18:24:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:20 INFO - Downloading/unpacking flake8 18:24:20 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 18:24:20 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 18:24:20 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 18:24:20 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 18:24:20 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 18:24:20 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 18:24:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:24:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:24:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:24:24 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 18:24:24 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 18:24:24 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 18:24:24 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 18:24:24 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 18:24:24 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 18:24:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:24:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:24:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:24:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:24:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:24:24 INFO - no previously-included directories found matching 'docs/_build' 18:24:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:24:24 INFO - Running setup.py install for pep8 18:24:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:24:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:24:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:24:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:24:24 INFO - no previously-included directories found matching 'docs/_build' 18:24:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:24:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:24:24 INFO - Cleaning up... 18:24:24 INFO - Return code: 0 18:24:24 INFO - Running post-action listener: _resource_record_post_action 18:24:24 INFO - Running post-action listener: _start_resource_monitoring 18:24:24 INFO - Starting resource monitoring. 18:24:24 INFO - ##### 18:24:24 INFO - ##### Running install step. 18:24:24 INFO - ##### 18:24:24 INFO - Running pre-action listener: _resource_record_pre_action 18:24:24 INFO - Running main action method: install 18:24:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:24:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:24:25 INFO - Reading from file tmpfile_stdout 18:24:25 INFO - Detecting whether we're running mozinstall >=1.0... 18:24:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:24:25 INFO - Reading from file tmpfile_stdout 18:24:25 INFO - Output received: 18:24:25 INFO - Usage: mozinstall [options] installer 18:24:25 INFO - Options: 18:24:25 INFO - -h, --help show this help message and exit 18:24:25 INFO - -d DEST, --destination=DEST 18:24:25 INFO - Directory to install application into. [default: 18:24:25 INFO - "/builds/slave/test"] 18:24:25 INFO - --app=APP Application being installed. [default: firefox] 18:24:25 INFO - mkdir: /builds/slave/test/build/application 18:24:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:24:58 INFO - Reading from file tmpfile_stdout 18:24:58 INFO - Output received: 18:24:58 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:24:58 INFO - Running post-action listener: _resource_record_post_action 18:24:58 INFO - ##### 18:24:58 INFO - ##### Running run-tests step. 18:24:58 INFO - ##### 18:24:58 INFO - Running pre-action listener: _resource_record_pre_action 18:24:58 INFO - Running main action method: run_tests 18:24:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:24:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:24:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:24:58 INFO - 2016-03-13 18:24:58.979 screenresolution[1916:15609] starting screenresolution argv=screenresolution get 18:24:58 INFO - 2016-03-13 18:24:58.982 screenresolution[1916:15609] Display 0: 1600x1200x32@60 18:24:58 INFO - 2016-03-13 18:24:58.988 screenresolution[1917:15613] starting screenresolution argv=screenresolution list 18:24:58 INFO - Available Modes on Display 0 18:24:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:24:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:24:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:24:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:24:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:24:59 INFO - Intel Iris: 18:24:59 INFO - Chipset Model: Intel Iris 18:24:59 INFO - Type: GPU 18:24:59 INFO - Bus: Built-In 18:24:59 INFO - VRAM (Dynamic, Max): 1536 MB 18:24:59 INFO - Vendor: Intel (0x8086) 18:24:59 INFO - Device ID: 0x0a2e 18:24:59 INFO - Revision ID: 0x0009 18:24:59 INFO - Displays: 18:24:59 INFO - Display: 18:24:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:24:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:24:59 INFO - Display Serial Number: 1600x1200 60 18:24:59 INFO - Main Display: Yes 18:24:59 INFO - Mirror: Off 18:24:59 INFO - Online: Yes 18:24:59 INFO - Rotation: Supported 18:24:59 INFO - Return code: 0 18:24:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:24:59 INFO - Python 2.7.3 18:24:59 INFO - Return code: 0 18:24:59 INFO - grabbing minidump binary from tooltool 18:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:59 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 0x110167d30>, '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 0x10ff8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11015eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:24:59 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 18:24:59 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 18:24:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:24:59 INFO - Return code: 0 18:24:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:24:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:24:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:24:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:24:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:24:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:25:00 INFO - Return code: 0 18:25:00 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/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0092', '--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 18:25:00 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/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0092 --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 18:25:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y1MUSjYWWI/Render', 18:25:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:25:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:25:00 INFO - 'HOME': '/Users/cltbld', 18:25:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:25:00 INFO - 'LOGNAME': 'cltbld', 18:25:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:25:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:00 INFO - 'MOZ_NO_REMOTE': '1', 18:25:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:25:00 INFO - 'NO_EM_RESTART': '1', 18:25:00 INFO - 'PAGER': '/bin/cat', 18:25:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:00 INFO - 'PWD': '/builds/slave/test', 18:25:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:25:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:25:00 INFO - 'SHELL': '/bin/bash', 18:25:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8t8q8pVwII/Listeners', 18:25:00 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 18:25:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:25:00 INFO - 'USER': 'cltbld', 18:25:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:25:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:00 INFO - 'XPC_FLAGS': '0x0', 18:25:00 INFO - 'XPC_SERVICE_NAME': '0', 18:25:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:25:00 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/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0092', '--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 18:25:00 INFO - mozversion application_buildid: 20160313160931 18:25:00 INFO - mozversion application_changeset: f0c0480732d36153e8839c7f17394d45f679f87d 18:25:00 INFO - mozversion application_display_name: Nightly 18:25:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:25:00 INFO - mozversion application_name: Firefox 18:25:00 INFO - mozversion application_remotingname: firefox 18:25:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:25:00 INFO - mozversion application_vendor: Mozilla 18:25:00 INFO - mozversion application_version: 48.0a1 18:25:00 INFO - mozversion platform_buildid: 20160313160931 18:25:00 INFO - mozversion platform_changeset: f0c0480732d36153e8839c7f17394d45f679f87d 18:25:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:25:00 INFO - mozversion platform_version: 48.0a1 18:25:00 INFO - using testdate: 1457918700 18:25:00 INFO - actual date: 1457918700 18:25:00 INFO - starting webserver on 'localhost:50873' 18:25:00 INFO - SUITE-START | Running 2 tests 18:25:00 INFO - TEST-START | dromaeo_css 18:25:00 INFO - operating with platform_type : mac_ 18:25:00 INFO - Initialising browser for dromaeo_css test... 18:25:00 INFO - TEST-INFO | started process 1935 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/tmpI988Oh/profile http://localhost:50873/getInfo.html) 18:25:03 INFO - PROCESS | 1935 | __metrics Screen width/height:1600/1200 18:25:03 INFO - PROCESS | 1935 | colorDepth:24 18:25:03 INFO - PROCESS | 1935 | Browser inner width/height: 1024/689 18:25:03 INFO - PROCESS | 1935 | __metrics 18:25:03 ERROR - PROCESS | 1935 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 18:25:04 INFO - TEST-INFO | 1935: exit 0 18:25:04 INFO - Browser initialized. 18:25:04 INFO - Running cycle 1/1 for dromaeo_css test... 18:25:04 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/tmpI988Oh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:25:16 INFO - PROCESS | 1939 | RSS: Main: 255139840 18:25:16 INFO - PROCESS | 1939 | 18:26:06 INFO - PROCESS | 1939 | 1457918766117 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] 18:28:17 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:50873/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50873/tests/dromaeo/cssquery-ext.html) 18:28:18 INFO - PROCESS | 1939 | RSS: Main: 268644352 18:28:18 INFO - PROCESS | 1939 | 18:31:20 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:50873/tests/dromaeo/cssquery-ext.html (next: http://localhost:50873/tests/dromaeo/cssquery-jquery.html) 18:31:21 INFO - PROCESS | 1939 | RSS: Main: 280281088 18:31:21 INFO - PROCESS | 1939 | 18:34:22 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:50873/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50873/tests/dromaeo/cssquery-mootools.html) 18:34:23 INFO - PROCESS | 1939 | RSS: Main: 282652672 18:34:23 INFO - PROCESS | 1939 | 18:37:25 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:50873/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50873/tests/dromaeo/cssquery-prototype.html) 18:37:25 INFO - PROCESS | 1939 | RSS: Main: 283942912 18:37:25 INFO - PROCESS | 1939 | 18:40:28 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:50873/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50873/tests/dromaeo/cssquery-yui.html) 18:40:29 INFO - PROCESS | 1939 | RSS: Main: 287551488 18:40:29 INFO - PROCESS | 1939 | 18:43:31 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:50873/tests/dromaeo/cssquery-yui.html (next: http://localhost:50873/tests/dromaeo/cssquery-dojo.html) 18:43:31 INFO - PROCESS | 1939 | RSS: Main: 287707136 18:43:31 INFO - PROCESS | 1939 | 18:43:31 INFO - PROCESS | 1939 | __start_tp_report 18:43:31 INFO - PROCESS | 1939 | _x_x_mozilla_page_load 18:43:31 INFO - PROCESS | 1939 | _x_x_mozilla_page_load_details 18:43:31 INFO - PROCESS | 1939 | |i|pagename|runs| 18:43:31 INFO - PROCESS | 1939 | |0;dojo.html;2890.653121625405;3468.7225021998233;3492.284081763238;3492.8215324055113;3566.482859985302;5179.456157103502;5377.247185394043;5783.277090363705;5797.130430435437;5828.708564571775;5663.773449062043;5750.6262092963925;5755.971220143893;5839.357670656224;5915.112733090039;5186.377634683843;5223.529882310591;5242.79028838846;5294.602904782138;5320.201969704556;5224.92162617561;5342.465753424646;5426.972865135669;5441.2654291670715;5447.509724124828;5057.367829021372;5110.514501122425;5181.093308670967;5207.791688332462;5324.387695415019;5242.842714718565;5245.082110630662;5245.186996015624;5264.447233040514;5297.205419187153;5140.7172605506685;5209.218617207412;5243.947560524384;5259.631825772198;5282.947170528284;4846.781894814707;5577.079781835992;5655.434456554352;5732.31212254528;5732.426757324276;5342.412334643186;6102.511799056109;6162.8767424651705;6164.568480206387;6165.7533698652;6110.892920173586;6139.079138129272;6187.350328215518;6208.068789681584;6209.254889413254;5897.233359663216;5899.46904778572;5899.882002359929;5906.704664766745;5950.9107363389585;6303.149074874833;6308.495320374359;6311.463525600284;6312.210973628296;6336.968315158395;6026.638401695912;6113.541484388688;6142.477889379364;6147.985582378947;6172.105044768484;6143.170671959318;6156.661383623944;6170.629762214281;6185.8144255672405;6191.164192834;6066.090086486974;6091.934084995663;6123.08153776937;6171.105189747462;6176.227971503562;6103.004334463713;6111.075205202202;6138.294096178996;6144.170536977451;6174;4956.355673762388;4960.503949605083;4965.677230979974;4972.8756781080765;4995.075910956485;4388.561143885586;4423.62399196072;4427.048184640318;4437.911241775147;4485.461744590605;5757.309122905278;5900.203472531153;5931.991561434566;5949.0481522956115;5980.850478738066;6118.832384214075;6142.600730952474;6191.566590338633;6215;6239.688015599202;5936.406359364029;5966.582339236212;5970.253718285215;5974.970125149346;5981.760729570856;5288.920666189933;5419.430959749248;5433.157860531624;5449.700266485302;5451.182322651634;6322.146510221061;6371.267304260069;6436.678166091677;6461.483081353386;6479.611223326427;6133.785317513865;6135.969320153549;6177;6181.258249010148;6210.534209934363;6255.593386429868;6348.492120630431;6412.775552855627;6417.422431981144;6452.645104519296;6106.005662907847;6193.876122477615;6198.597091189058;6204.5967012144065;6216.937830621636;6191.566590338633;6194.163787888578;6197.938020619917;6203.906941395973;6285.811425657238;6011.338752737282;6092.0252759560035;6152.107944348134;6154.969225153845;6162.106494558354;6021.7591296347655;6117.877642447037;6118.663473509;6122.112293717475;6181.598196117238;5951.970240148945;5959.642421454727;5974.342822289458;6011.308699499614;6014.879702406015;5997.310309314485;6117.096718007379;6132.8773424532155;6134.6625935573975;6165.876682466415;6047.637141771508;6051.6369017857305;6056.454919057306;6057.1519987200945;6099.390060994043 18:43:31 INFO - PROCESS | 1939 | |1;ext.html;441.07154439904;475.7621189405297;545.1818186348528;616.6546733829055;651.7458191305391;37271.62728372715;37785.62214377856;37923.81038094809;37930.24139517208;37942.24115517688;28800.711992880064;30463.238419039535;35108.824455877686;38793.61206387935;39292;9282.628694852197;9444.102810233051;9502.429854208769;9550.761230969212;9554.856677149848;9350.812983740321;9589;9632.56653450593;9640.80718385632;9652.565634546427;9408.29437792165;9449.81100377992;9520.8571871422;9524.999875013127;9537.570809313598;9517.238620910346;9627.47048912313;9632.036796320383;9643.373180743229;9653.22774178064;9545.856812147824;9616;9667.806643867154;9671.371360861522;9687.273454490942;33174.50238246404;38453.80773096117;38534.42198367027;38559.03602409934;38602.22795544101;3095.7059079387423;3193.1857376368876;3333.8833140839956;3354.3794398036443;3464.636213197603;27061.188164355102;27738.861305693343;27798;27846.3038424039;28257;2638.261286839688;2702.2568793581922;2721.6189733437336;2731;2813.296675831042;434046;435038;438994;439910.8004459989;441359.7932010319;44781.328280075824;45625.54374456279;61288.69355653193;63076.684616576626;63206.36793632097;44865;45241.09517809626;45348.54651453509;45384;45597.54402456;15162.24188790556;15284.38862445512;15286.770698439532;15306.693866122616;15318.234088295763;11969.700757480958;12057.698557536132;12155.331456769785;12182.269063856196;12196.329201893803;14438.855611443962;14583.562493125222;14777.482788102365;14838.477458832025;14853.2573371331;5476.808311709071;6270.968645156745;6400.9039864402075;6413.551051426355;6424.453921416639;810.4731924249168;982.3369225772575;1010.7877345757327;1012.8328825743818;1071.244772435431;24938.625920611204;25116.24651260465;29756.40487190244;29885.850570747443;31580.842095789372;979.4564016970508;1057.9047885690325;1072.0887245840972;1126.4649291586431;1132.2357408749062;11947.207918812248;12136.45385957634;14112.01215914876;14514.927425362806;14763.557093287218;630321;633069;642952;644480;646291;49437.25844112341;58185.709071454374;58279.834403311695;58744.41255587475;58893.411065889646;1378.4486205517674;1405.8242719660043;1410.4851729119002;1428.0860249440366;1434.5767998440485;28067.438651226454;28075.73659185301;28079.97064569566;28527.572086419135;28632.284192895346;48557.514424856716;48564;48586;49053.50946490489;49081.50918490912;406343;407510;408693.95653021545;409381;410536;30064.84967575148;31717.524237136924;32703.672963270063;33236.335273294884;33546.66453335436;35377.11557210988;43074.78462607667;43533.34699979566;43801.78099109484;44414;35777.82111089428;36061.63938360583;36247;36901.26197476089;37144;30067.248318792204;35119.29761404809;35892.49041877574;36071.639283606826;36976.81511592425;30668.539971900886;35049.59801607907;35138.29723405569;36196.81901590475;36494.63505364912;29820.85089574538;30110.838361971677;30125.397492050473;30171.849140754155;30350.696493034786;20783.896080519502;23576.410589735395;24015.159469419184;24166.637500437155;24467.021319147036 18:43:31 INFO - PROCESS | 1939 | |2;jquery.html;317.38585836406554;348.6182630020128;349.98504337421474;351.8012323037482;365.12552436913575;17494.21276042578;19637.607247855034;20773.27293544726;20980.580388392224;21005.579888402222;20317.88251646159;20968.475788105305;21212.363629091153;21215.257465988692;21236.8938155309;5494.780208791643;5751;5798.768049278024;5817.534597232211;5841.853953651172;4121.711480196387;6062.848428789272;6480.675966201695;6496.123023391852;6508.837279068038;6414.134091897581;6420.839479013039;6432.292447830735;6454;6904.9654751726175;6340.968295158495;7062.470314726416;7122.824733918897;7123.145222573273;7170.354668079872;6654.767083152066;7074.186468556079;7102.183248926388;7114.57312561248;7124.928750712478;25775.613365799527;26549.601755973676;26913;26931.32671683204;27411.451770964668;2187.7484089329773;2266;2339.675547755533;2595.8961641534315;3034;12903.483860645563;15300.186258794887;15358;15640.139792311418;16006.519804405887;1670.991645041779;1860.5348662834292;1871.56018335691;1950.1126987220923;1956.383739122172;106653.46673266661;115065;115721.84278157195;116148.41925790401;116589.41705291504;15606.843931560767;19324.420267392;19562.60874782525;19775.703364449546;19855.205791768458;28695.42609147847;29143.271418214714;29198.416031679673;29228;29299.85350073236;10502.632407865687;10671.466426678635;10808.97314755097;10843.83734243987;10982.615608453665;7481.027466429438;9055.81888362229;9112.544372781467;9135.634574617074;9225.354225204306;8046.1551537088935;8946;8989.146031127033;8999.460032398078;9015.27877769777;1664.0265444714735;1874.8406385457115;1954.7263383126374;1972.053414361086;1977.0905383523452;881.5460038080394;931.1759093202429;993.1855878179967;1025.5590096258532;1047.9056884880397;19429.611407771765;19683.901580492293;20230.494237644176;20307.081231318905;20868.79131208699;929.8419268724333;939.4316438554713;957.3868032365486;961.5144352102284;965.3242730088825;10919.071878890225;11050.950159734812;11124.55501779936;11275.548978040786;11305.943470282597;614519;647981;649895;655206;661950;118896;120589;123198.38400807939;125260;132101;994.3089552760906;1054.4464156317995;1058.3544038136731;1058.6453538064682;1065.0308219520355;13504.662383440493;18398.08009599488;18786.060696964825;18866.71699924475;18935.526611834262;37135.81432092822;49430;49860.501394985586;51003.489965101355;51060;70204.13877236801;70315.64842175962;74520;75746.62126689331;76648.61675691586;7447.255274472726;7599.696012159452;7647.847043059219;7701.768946931601;7964.2433968772875;7964.960175199087;12060.396980150781;12122.515099395925;12251;12281.631551053482;8449.66201351939;9468.905310946802;10159.695209143738;10509.31689440184;10622.681319560426;8367.330613551023;10366.844497332395;10444.791104178026;10606.681799546026;10635.415052172204;5614.326280846324;8249.958750206211;8640.703894415888;9131;10757.838632420677;7562.584057876869;7651.4261430391825;7704;7723.227677232457;7817.882731759142;9155.587998540215;9328.207102396373;10324.845127322946;10466;10857.945710271399 18:43:31 INFO - PROCESS | 1939 | |3;mootools.html;1465.4358072142225;1598.7761713360132;1819.5451137215696;1961.2743284984558;1982.6728589782686;7910.208979102087;8741.344399170055;8835.072317406677;9015.549222538872;9038.457692538452;8779.165979231979;8806;8878.689245876396;8878.689245876396;8886.333524985619;2123.681447782837;2494.526040052389;2507.6238564215423;2511.3972646564785;2512.472380800034;2104.4738815296178;2474.6288056791445;2511.9120830770835;2518.798496120315;2525.368657835541;2493.1523282084086;2505.7243703192635;2525.2424272718204;2540.0728734012046;2542.1102614085107;2497.400623850281;2516.509280690266;2522.1928982725444;2531.2785856031037;2540.593505039185;2499.150288901764;2524.5960646296503;2525.1414519063424;2528.1783420388265;2538.3019669590826;8976.910230897673;9002.86495702565;9020.8646870297;9022.052684468168;9023.278137748965;5465.234867118606;5559;5569.777208911639;5616.943830561683;5627;3573.427691815593;3675.5956844747056;3695.7043436525014;3722.664960153572;3752.3245815753153;1039.7816458543714;1048.9370637761758;1063.059192614534;1066.0352381095045;1080.0441609175857;11911.940440297829;12006.459709313101;12145.878541214563;12174.878251217464;12175.817362739566;4917.877053073702;4950.554450099508;5022.472640372781;5027.044861476308;5028.396592408934;8315.459495132796;10281.485925703684;10309.48452577383;10323.432211228455;10328.845067323997;5444.237806707064;5501.339839219239;5509.669419834742;5516.117421212587;5527;4538.273876179861;4921.655484116149;4922;4930.457649658535;5051.823186188466;3940.0937784309767;4008.5590585035625;4014.297497937849;4071.0840060986043;4108.609682080198;1324.7549203397402;1348.1169833758904;1349.8312710911136;1355.0650051464459;1361.720847226336;1305.902057345684;1342.047146525958;1342.4495956657724;1345.9259740714356;1405.0305289350315;8058.919410805935;8271.834563308821;8277.54473503963;8323.916760832315;8364.414490985695;446.187937952929;508.97964081437067;520.828126718182;523.0558841291505;524.9081410753103;6193.6903154842075;6247.031710084944;6269.498440124779;6285.120083188357;6296.716647750771;10372.636957706443;10465.895341046644;10513.158947284199;10583.206259530565;10636.989485998818;10226.795464090825;10426.374417534973;10487.475626218658;10507.474626268657;10549.789004219872;8235.95882020586;8289.751307460785;8362.58187090643;8368.20502052304;8370.581470926429;8058.959705201437;8118.715844945635;8126.715564955198;8180.8363832721825;8386.161383861565;9604.327697061139;9771.706848794547;9813.950930245303;9833;9836.60653573849;9785.951070244888;10103.24225683062;10179.592816287563;10241.487925603838;10355.01627345401;6747.730090796314;7526.887096693664;7594.392448604209;7638.388928885787;7755.379569634303;8315.750527484186;8348.624311905858;8368.790780230544;8371.16288371158;8387.412881098264;6533.607983521004;7354.852902941804;7449.888251676338;7489.925100748923;7628.656710448154;6224;6356.650384228912;7319.560826350436;7337.046183996046;7521.849563008818;7526.5107767994905;7694.576798275924;7728.806779830325;7734.381249499914;7764.961175194314;7012.754553590804;7052.153741550842;7069.257727938492;7112.928870711434;7162.964185179041;7099.148102227766;7237.674304656409;7247.91281307808;7274.672639731119;7295.7081716732855 18:43:31 INFO - PROCESS | 1939 | |4;prototype.html;314.7969559634036;324.7045188878121;328.64013904774265;332.1530098249463;332.5012481278083;5458;6843.452523798097;6884.5525040872435;6885;6920.996455513948;5375.650582712131;6688.498362622799;6739.0902228199175;6756.527043106985;6790.660466976644;4870.220764677652;4960.479149689285;5063.240513922904;5091.312672789181;5130.743462826853;5050.898982020358;5065.468125846788;5069.315642388286;5075.137226671474;5099.898002039957;5001.199808030716;5011.67424117433;5034.42104158021;5037;5050.747462626872;5001.524855138756;5018.673786203922;5035.697858128506;5036.4208116066575;5037.909267653919;3592.892213233607;3821.3694740367805;4101.666958238585;4336.934945975813;4350.2387082260475;5328.5470734987575;5519.074890308143;6313.400226978476;6627.867442651168;6642.036904648847;5738;5839.270091238595;5858.297004359504;5858.794942177004;5859.355470898197;7319.926800731978;7320.304571065741;7334.083239595051;7341.1557670868;7354.889676654854;4653.837115700934;4656.953430465685;4657.022025374676;4658.440987081538;4659.5573420525;7338.412926965883;7668.309852113337;7748.024253815297;7760.883586746203;7775.727849525239;4596.2416201326405;4609.469910960215;4700.741459219707;4712.693674911188;4730.101280756645;4786.856394308176;4792.640551958617;4795.400574928134;4797.544233297831;4812.181929072066;4998.750062496933;5509.834704958857;5690.5163061140265;5752.28096487939;5780.450857168562;7321.450891183183;7328.083989501312;7328.67020984057;7345.963270183614;7355;1564.0615630621537;1610.8147563030168;1618.757186422046;1647.7116504611645;1650.6533627938268;1044.3629386074488;1053.847192157133;1062.2404980438869;1067.813132701774;1068.7648717282186;6255.499560035186;6822;6835.282295358916;6844.965775171092;6901.240863505011;6134.877302454015;6540.4767618590395;7569.735059273009;7582.54504729707;7613.695452181962;6853.246142924274;6857.759978400732;6859.3140685932;6866.313368663094;6988.755393561201;3370.0563842124243;3586.30067136911;3997.8400863965117;4023.275810354106;4045.939310910339;6595.934040659628;6754.763583274562;7863;8049.074356448966;8062.234087761653;7845.843083138419;7910.16943220965;7911.378167475654;7915.327197188189;7917.960410198028;7997.5601341925585;8016.55908925003;8021.197880211932;8033.277005069572;8050.718224862102;7301.452391070585;7635;7643.808904777425;7659.770206893802;7667.693292268247;7456.105267367951;7461.365783908429;7465.4027677786735;7466;7487.5507469552;6477.902831457438;7953.204679532;7959.9602001989615;7979.202079791974;7990.121086680577;4696.38946936896;4755.952440475689;4763.166445872028;4767.165745994506;4772.952270477251;7353.227911069261;7606.581638009962;7654.081510218809;7654.502457340255;7675.5010924289745;6679.532432729662;6757.797266082025;7340.596267205141;7361.742339018108;7369.889451658122;7345.77962661121;7393.519421237603;7406.925930740624;7424.96287518559;7439.739609113655;7157.57054576727;7173.820654483471;7215.783526494003;7218.133823941161;7222.313880181375;6637.269900311058;6810.727570897108;7352.852942941218;7388.778336649909;7406.5926374047785;7183.928160718535;7220.89168662481;7231.963840180765;7233.3851622612665;7242.746503872339 18:43:31 INFO - PROCESS | 1939 | |5;yui.html;692.2834865913778;718.3104219948849;743.215907217885;775.1589525364978;776.1113525013859;14968.32642531086;15187.772183417257;15225.390984360612;15244.61888452788;15257.847421525781;13878;14075.648108797259;14141.080829746059;14149.434022639109;14195.148291102541;711.3562226185311;918.9448633082003;920.9907900921005;931.1340453378356;931.7996630724393;912.4707669551644;922.598669578732;923.1829830599934;924.7872989212485;926.819270242303;972.2853702528636;975.0834215837091;975.7755716185281;976.4727047394399;976.716752141878;963.4460185393357;967.4630580028081;970.8301047316692;975.2880397309968;975.5463709375103;705.8447141628833;721.90976127984;726.8255618651539;730.1420830524113;732.42870560962;13250.271235082068;13282.203067815866;13284.202947823162;13317.800232996513;13396.196228226338;11143.665690029313;11257.268277562014;11695.649130526097;12273.263604183778;12586.559470418491;9799.461029643368;9854.556544955494;9902;9937.155341795957;10007.099361057468;3513.543239378864;3525.594556625995;3554.36021516127;3571.5178450909057;3592.281543691246;70624;80512.79230811483;81566;81572.59213703894;86127;9725.56234969428;9797.951010244904;9833.4099954003;9880.40717556949;9965.900340996643;21606.996853398206;22304.665430018238;22386.888065559568;22447.55104897893;22469.775302247097;7641.923580764233;7793.376529877596;7833.92166078332;7910.920890791133;7992.200779921961;4073.551909289976;4148.668106551529;4173.9582604174175;4174.979125104355;4192.832286708558;3635.6727894489622;3668.486411902336;3669.522962014921;3675;3685.8341374638208;578.4475825586638;653.1313353240179;695.3220609905302;698.8252936765808;699.2727563334178;499.93500844889934;518.0623072239184;545.4000599340773;582.8309790160806;594.3933182674541;8042.831647828743;8283.50298982063;8333.499990000499;8359.916400835913;8417.158284171657;487.4930072724398;549.5301517202814;551.1752269618206;559.5383808358121;590.008591875951;3567.6253993330847;3766;4161.56303588125;4233.322668373045;4339.327404252346;94564.52717736505;97349;97546;97708.51145744367;99135;59049;81988.18011819806;82111.5894420536;82169.17830821616;82463;66694;67143.32856671468;67667.32332676709;68288.65855670789;68632.6568367155;7558.2441755823975;7664.923350766421;8526.659433966997;8545.786355341166;8548.829023419621;40683;48507.757461212466;50261;50389;50857.491425085274;55777.44222557722;66563;68439.31560684329;70750.64624676843;71316.28683713096;11011.61459348919;11185.440727963733;11278.266912650652;11281.379524126252;11475.713107172387;11878.643640690792;12186.6953326164;12411.255324680547;12422;12706.047046471736;11541.653750387502;11556.59551915679;11953.103517236415;12007.939960300142;12142.028637709138;10832.566697332019;11693.941530292293;11835.70410739704;11962.58130965412;11997.76004479923;9941.403515789076;11419.657410277705;11602.825957610812;11814;12395.75208495843;9642.951785241028;9831.606735730491;9870.703878883645;9927.503624818586;10127.7468063299;9046.90953090487;9077.863832042392;9301.162895339452;9679.274054445805;9742.853857192289 18:43:31 INFO - PROCESS | 1939 | __end_tp_report 18:43:31 INFO - PROCESS | 1939 | __start_cc_report 18:43:31 INFO - PROCESS | 1939 | _x_x_mozilla_cycle_collect,372 18:43:31 INFO - PROCESS | 1939 | __end_cc_report 18:43:31 INFO - PROCESS | 1939 | __startTimestamp1457919811869__endTimestamp 18:43:31 INFO - PROCESS | 1939 | 18:43:31 INFO - PROCESS | 1939 | ------- Summary: start ------- 18:43:31 INFO - PROCESS | 1939 | Number of tests: 6 18:43:31 INFO - PROCESS | 1939 | 18:43:31 INFO - PROCESS | 1939 | [#0] dojo.html Cycles:165 Average:5760.52 Median:6014.88 stddev:634.20 (10.5%) stddev-sans-first:594.85 18:43:31 INFO - PROCESS | 1939 | Values: 2890.7 3468.7 3492.3 3492.8 3566.5 5179.5 5377.2 5783.3 5797.1 5828.7 5663.8 5750.6 5756.0 5839.4 5915.1 5186.4 5223.5 5242.8 5294.6 5320.2 5224.9 5342.5 5427.0 5441.3 5447.5 5057.4 5110.5 5181.1 5207.8 5324.4 5242.8 5245.1 5245.2 5264.4 5297.2 5140.7 5209.2 5243.9 5259.6 5282.9 4846.8 5577.1 5655.4 5732.3 5732.4 5342.4 6102.5 6162.9 6164.6 6165.8 6110.9 6139.1 6187.4 6208.1 6209.3 5897.2 5899.5 5899.9 5906.7 5950.9 6303.1 6308.5 6311.5 6312.2 6337.0 6026.6 6113.5 6142.5 6148.0 6172.1 6143.2 6156.7 6170.6 6185.8 6191.2 6066.1 6091.9 6123.1 6171.1 6176.2 6103.0 6111.1 6138.3 6144.2 6174.0 4956.4 4960.5 4965.7 4972.9 4995.1 4388.6 4423.6 4427.0 4437.9 4485.5 5757.3 5900.2 5932.0 5949.0 5980.9 6118.8 6142.6 6191.6 6215.0 6239.7 5936.4 5966.6 5970.3 5975.0 5981.8 5288.9 5419.4 5433.2 5449.7 5451.2 6322.1 6371.3 6436.7 6461.5 6479.6 6133.8 6136.0 6177.0 6181.3 6210.5 6255.6 6348.5 6412.8 6417.4 6452.6 6106.0 6193.9 6198.6 6204.6 6216.9 6191.6 6194.2 6197.9 6203.9 6285.8 6011.3 6092.0 6152.1 6155.0 6162.1 6021.8 6117.9 6118.7 6122.1 6181.6 5952.0 5959.6 5974.3 6011.3 6014.9 5997.3 6117.1 6132.9 6134.7 6165.9 6047.6 6051.6 6056.5 6057.2 6099.4 18:43:31 INFO - PROCESS | 1939 | 18:43:31 INFO - PROCESS | 1939 | [#1] ext.html Cycles:180 Average:62208.09 Median:37060.41 stddev:135238.68 (364.9%) stddev-sans-first:135538.55 18:43:31 INFO - PROCESS | 1939 | Values: 441.1 475.8 545.2 616.7 651.7 37271.6 37785.6 37923.8 37930.2 37942.2 28800.7 30463.2 35108.8 38793.6 39292.0 9282.6 9444.1 9502.4 9550.8 9554.9 9350.8 9589.0 9632.6 9640.8 9652.6 9408.3 9449.8 9520.9 9525.0 9537.6 9517.2 9627.5 9632.0 9643.4 9653.2 9545.9 9616.0 9667.8 9671.4 9687.3 33174.5 38453.8 38534.4 38559.0 38602.2 3095.7 3193.2 3333.9 3354.4 3464.6 27061.2 27738.9 27798.0 27846.3 28257.0 2638.3 2702.3 2721.6 2731.0 2813.3 434046.0 435038.0 438994.0 439910.8 441359.8 44781.3 45625.5 61288.7 63076.7 63206.4 44865.0 45241.1 45348.5 45384.0 45597.5 15162.2 15284.4 15286.8 15306.7 15318.2 11969.7 12057.7 12155.3 12182.3 12196.3 14438.9 14583.6 14777.5 14838.5 14853.3 5476.8 6271.0 6400.9 6413.6 6424.5 810.5 982.3 1010.8 1012.8 1071.2 24938.6 25116.2 29756.4 29885.9 31580.8 979.5 1057.9 1072.1 1126.5 1132.2 11947.2 12136.5 14112.0 14514.9 14763.6 630321.0 633069.0 642952.0 644480.0 646291.0 49437.3 58185.7 58279.8 58744.4 58893.4 1378.4 1405.8 1410.5 1428.1 1434.6 28067.4 28075.7 28080.0 28527.6 28632.3 48557.5 48564.0 48586.0 49053.5 49081.5 406343.0 407510.0 408694.0 409381.0 410536.0 30064.8 31717.5 32703.7 33236.3 33546.7 35377.1 43074.8 43533.3 43801.8 44414.0 35777.8 36061.6 36247.0 36901.3 37144.0 30067.2 35119.3 35892.5 36071.6 36976.8 30668.5 35049.6 35138.3 36196.8 36494.6 29820.9 30110.8 30125.4 30171.8 30350.7 20783.9 23576.4 24015.2 24166.6 24467.0 18:43:31 INFO - PROCESS | 1939 | 18:43:31 INFO - PROCESS | 1939 | [#2] jquery.html Cycles:180 Average:36665.80 Median:28919.35 stddev:107036.86 (370.1%) stddev-sans-first:107302.33 18:43:31 INFO - PROCESS | 1939 | Values: 317.4 348.6 350.0 351.8 365.1 17494.2 19637.6 20773.3 20980.6 21005.6 20317.9 20968.5 21212.4 21215.3 21236.9 5494.8 5751.0 5798.8 5817.5 5841.9 4121.7 6062.8 6480.7 6496.1 6508.8 6414.1 6420.8 6432.3 6454.0 6905.0 6341.0 7062.5 7122.8 7123.1 7170.4 6654.8 7074.2 7102.2 7114.6 7124.9 25775.6 26549.6 26913.0 26931.3 27411.5 2187.7 2266.0 2339.7 2595.9 3034.0 12903.5 15300.2 15358.0 15640.1 16006.5 1671.0 1860.5 1871.6 1950.1 1956.4 106653.5 115065.0 115721.8 116148.4 116589.4 15606.8 19324.4 19562.6 19775.7 19855.2 28695.4 29143.3 29198.4 29228.0 29299.9 10502.6 10671.5 10809.0 10843.8 10982.6 7481.0 9055.8 9112.5 9135.6 9225.4 8046.2 8946.0 8989.1 8999.5 9015.3 1664.0 1874.8 1954.7 1972.1 1977.1 881.5 931.2 993.2 1025.6 1047.9 19429.6 19683.9 20230.5 20307.1 20868.8 929.8 939.4 957.4 961.5 965.3 10919.1 11051.0 11124.6 11275.5 11305.9 614519.0 647981.0 649895.0 655206.0 661950.0 118896.0 120589.0 123198.4 125260.0 132101.0 994.3 1054.4 1058.4 1058.6 1065.0 13504.7 18398.1 18786.1 18866.7 18935.5 37135.8 49430.0 49860.5 51003.5 51060.0 70204.1 70315.6 74520.0 75746.6 76648.6 7447.3 7599.7 7647.8 7701.8 7964.2 7965.0 12060.4 12122.5 12251.0 12281.6 8449.7 9468.9 10159.7 10509.3 10622.7 8367.3 10366.8 10444.8 10606.7 10635.4 5614.3 8250.0 8640.7 9131.0 10757.8 7562.6 7651.4 7704.0 7723.2 7817.9 9155.6 9328.2 10324.8 10466.0 10857.9 18:43:31 INFO - PROCESS | 1939 | 18:43:31 INFO - PROCESS | 1939 | [#3] mootools.html Cycles:180 Average:6099.50 Median:521.94 stddev:3215.60 (616.1%) stddev-sans-first:3205.75 18:43:31 INFO - PROCESS | 1939 | Values: 1465.4 1598.8 1819.5 1961.3 1982.7 7910.2 8741.3 8835.1 9015.5 9038.5 8779.2 8806.0 8878.7 8878.7 8886.3 2123.7 2494.5 2507.6 2511.4 2512.5 2104.5 2474.6 2511.9 2518.8 2525.4 2493.2 2505.7 2525.2 2540.1 2542.1 2497.4 2516.5 2522.2 2531.3 2540.6 2499.2 2524.6 2525.1 2528.2 2538.3 8976.9 9002.9 9020.9 9022.1 9023.3 5465.2 5559.0 5569.8 5616.9 5627.0 3573.4 3675.6 3695.7 3722.7 3752.3 1039.8 1048.9 1063.1 1066.0 1080.0 11911.9 12006.5 12145.9 12174.9 12175.8 4917.9 4950.6 5022.5 5027.0 5028.4 8315.5 10281.5 10309.5 10323.4 10328.8 5444.2 5501.3 5509.7 5516.1 5527.0 4538.3 4921.7 4922.0 4930.5 5051.8 3940.1 4008.6 4014.3 4071.1 4108.6 1324.8 1348.1 1349.8 1355.1 1361.7 1305.9 1342.0 1342.4 1345.9 1405.0 8058.9 8271.8 8277.5 8323.9 8364.4 446.2 509.0 520.8 523.1 524.9 6193.7 6247.0 6269.5 6285.1 6296.7 10372.6 10465.9 10513.2 10583.2 10637.0 10226.8 10426.4 10487.5 10507.5 10549.8 8236.0 8289.8 8362.6 8368.2 8370.6 8059.0 8118.7 8126.7 8180.8 8386.2 9604.3 9771.7 9814.0 9833.0 9836.6 9786.0 10103.2 10179.6 10241.5 10355.0 6747.7 7526.9 7594.4 7638.4 7755.4 8315.8 8348.6 8368.8 8371.2 8387.4 6533.6 7354.9 7449.9 7489.9 7628.7 6224.0 6356.7 7319.6 7337.0 7521.8 7526.5 7694.6 7728.8 7734.4 7765.0 7012.8 7052.2 7069.3 7112.9 7163.0 7099.1 7237.7 7247.9 7274.7 7295.7 18:43:31 INFO - PROCESS | 1939 | 18:43:31 INFO - PROCESS | 1939 | [#4] prototype.html Cycles:180 Average:5921.68 Median:6746.93 stddev:1935.08 (28.7%) stddev-sans-first:1894.19 18:43:31 INFO - PROCESS | 1939 | Values: 314.8 324.7 328.6 332.2 332.5 5458.0 6843.5 6884.6 6885.0 6921.0 5375.7 6688.5 6739.1 6756.5 6790.7 4870.2 4960.5 5063.2 5091.3 5130.7 5050.9 5065.5 5069.3 5075.1 5099.9 5001.2 5011.7 5034.4 5037.0 5050.7 5001.5 5018.7 5035.7 5036.4 5037.9 3592.9 3821.4 4101.7 4336.9 4350.2 5328.5 5519.1 6313.4 6627.9 6642.0 5738.0 5839.3 5858.3 5858.8 5859.4 7319.9 7320.3 7334.1 7341.2 7354.9 4653.8 4657.0 4657.0 4658.4 4659.6 7338.4 7668.3 7748.0 7760.9 7775.7 4596.2 4609.5 4700.7 4712.7 4730.1 4786.9 4792.6 4795.4 4797.5 4812.2 4998.8 5509.8 5690.5 5752.3 5780.5 7321.5 7328.1 7328.7 7346.0 7355.0 1564.1 1610.8 1618.8 1647.7 1650.7 1044.4 1053.8 1062.2 1067.8 1068.8 6255.5 6822.0 6835.3 6845.0 6901.2 6134.9 6540.5 7569.7 7582.5 7613.7 6853.2 6857.8 6859.3 6866.3 6988.8 3370.1 3586.3 3997.8 4023.3 4045.9 6595.9 6754.8 7863.0 8049.1 8062.2 7845.8 7910.2 7911.4 7915.3 7918.0 7997.6 8016.6 8021.2 8033.3 8050.7 7301.5 7635.0 7643.8 7659.8 7667.7 7456.1 7461.4 7465.4 7466.0 7487.6 6477.9 7953.2 7960.0 7979.2 7990.1 4696.4 4756.0 4763.2 4767.2 4773.0 7353.2 7606.6 7654.1 7654.5 7675.5 6679.5 6757.8 7340.6 7361.7 7369.9 7345.8 7393.5 7406.9 7425.0 7439.7 7157.6 7173.8 7215.8 7218.1 7222.3 6637.3 6810.7 7352.9 7388.8 7406.6 7183.9 7220.9 7232.0 7233.4 7242.7 18:43:31 INFO - PROCESS | 1939 | 18:43:31 INFO - PROCESS | 1939 | [#5] yui.html Cycles:180 Average:18279.03 Median:66628.50 stddev:25848.30 (38.8%) stddev-sans-first:25887.08 18:43:31 INFO - PROCESS | 1939 | Values: 692.3 718.3 743.2 775.2 776.1 14968.3 15187.8 15225.4 15244.6 15257.8 13878.0 14075.6 14141.1 14149.4 14195.1 711.4 918.9 921.0 931.1 931.8 912.5 922.6 923.2 924.8 926.8 972.3 975.1 975.8 976.5 976.7 963.4 967.5 970.8 975.3 975.5 705.8 721.9 726.8 730.1 732.4 13250.3 13282.2 13284.2 13317.8 13396.2 11143.7 11257.3 11695.6 12273.3 12586.6 9799.5 9854.6 9902.0 9937.2 10007.1 3513.5 3525.6 3554.4 3571.5 3592.3 70624.0 80512.8 81566.0 81572.6 86127.0 9725.6 9798.0 9833.4 9880.4 9965.9 21607.0 22304.7 22386.9 22447.6 22469.8 7641.9 7793.4 7833.9 7910.9 7992.2 4073.6 4148.7 4174.0 4175.0 4192.8 3635.7 3668.5 3669.5 3675.0 3685.8 578.4 653.1 695.3 698.8 699.3 499.9 518.1 545.4 582.8 594.4 8042.8 8283.5 8333.5 8359.9 8417.2 487.5 549.5 551.2 559.5 590.0 3567.6 3766.0 4161.6 4233.3 4339.3 94564.5 97349.0 97546.0 97708.5 99135.0 59049.0 81988.2 82111.6 82169.2 82463.0 66694.0 67143.3 67667.3 68288.7 68632.7 7558.2 7664.9 8526.7 8545.8 8548.8 40683.0 48507.8 50261.0 50389.0 50857.5 55777.4 66563.0 68439.3 70750.6 71316.3 11011.6 11185.4 11278.3 11281.4 11475.7 11878.6 12186.7 12411.3 12422.0 12706.0 11541.7 11556.6 11953.1 12007.9 12142.0 10832.6 11693.9 11835.7 11962.6 11997.8 9941.4 11419.7 11602.8 11814.0 12395.8 9643.0 9831.6 9870.7 9927.5 10127.7 9046.9 9077.9 9301.2 9679.3 9742.9 18:43:31 INFO - PROCESS | 1939 | -------- Summary: end -------- 18:43:31 INFO - PROCESS | 1939 | 18:43:32 INFO - TEST-INFO | 1939: exit 0 18:43:32 INFO - TEST-OK | dromaeo_css | took 1111680ms 18:43:32 INFO - TEST-START | kraken 18:43:32 INFO - operating with platform_type : mac_ 18:43:32 INFO - Initialising browser for kraken test... 18:43:32 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/tmp_S75PU/profile http://localhost:50873/getInfo.html) 18:43:35 INFO - PROCESS | 1945 | __metrics Screen width/height:1600/1200 18:43:35 INFO - PROCESS | 1945 | colorDepth:24 18:43:35 INFO - PROCESS | 1945 | Browser inner width/height: 1024/689 18:43:35 INFO - PROCESS | 1945 | __metrics 18:43:35 ERROR - PROCESS | 1945 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 18:43:36 INFO - TEST-INFO | 1945: exit 0 18:43:36 INFO - Browser initialized. 18:43:36 INFO - Running cycle 1/1 for kraken test... 18:43:36 INFO - TEST-INFO | started process 1948 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/tmp_S75PU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:43:48 INFO - PROCESS | 1948 | RSS: Main: 255811584 18:43:48 INFO - PROCESS | 1948 | 18:43:50 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:50873/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50873/tests/kraken/driver.html?testName=audio-beat-detection) 18:43:51 INFO - PROCESS | 1948 | RSS: Main: 268972032 18:43:51 INFO - PROCESS | 1948 | 18:43:53 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:50873/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50873/tests/kraken/driver.html?testName=audio-dft) 18:43:54 INFO - PROCESS | 1948 | RSS: Main: 276541440 18:43:54 INFO - PROCESS | 1948 | 18:44:00 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:50873/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50873/tests/kraken/driver.html?testName=audio-fft) 18:44:00 INFO - PROCESS | 1948 | RSS: Main: 281407488 18:44:00 INFO - PROCESS | 1948 | 18:44:02 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:50873/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50873/tests/kraken/driver.html?testName=audio-oscillator) 18:44:03 INFO - PROCESS | 1948 | RSS: Main: 283856896 18:44:03 INFO - PROCESS | 1948 | 18:44:05 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:50873/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50873/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:44:06 INFO - PROCESS | 1948 | RSS: Main: 283897856 18:44:06 INFO - PROCESS | 1948 | 18:44:09 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:50873/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50873/tests/kraken/driver.html?testName=imaging-darkroom) 18:44:09 INFO - PROCESS | 1948 | RSS: Main: 282705920 18:44:09 INFO - PROCESS | 1948 | 18:44:13 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:50873/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50873/tests/kraken/driver.html?testName=imaging-desaturate) 18:44:14 INFO - PROCESS | 1948 | RSS: Main: 282202112 18:44:14 INFO - PROCESS | 1948 | 18:44:17 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:50873/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50873/tests/kraken/driver.html?testName=json-parse-financial) 18:44:17 INFO - PROCESS | 1948 | RSS: Main: 281821184 18:44:17 INFO - PROCESS | 1948 | 18:44:19 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:50873/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50873/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:44:19 INFO - PROCESS | 1948 | RSS: Main: 282746880 18:44:19 INFO - PROCESS | 1948 | 18:44:21 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:50873/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50873/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:44:22 INFO - PROCESS | 1948 | RSS: Main: 282103808 18:44:22 INFO - PROCESS | 1948 | 18:44:24 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:50873/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50873/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:44:25 INFO - PROCESS | 1948 | RSS: Main: 284000256 18:44:25 INFO - PROCESS | 1948 | 18:44:27 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:50873/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50873/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:44:28 INFO - PROCESS | 1948 | RSS: Main: 282431488 18:44:28 INFO - PROCESS | 1948 | 18:44:30 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:50873/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50873/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:44:31 INFO - PROCESS | 1948 | RSS: Main: 282550272 18:44:31 INFO - PROCESS | 1948 | 18:44:33 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:50873/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50873/tests/kraken/driver.html?testName=ai-astar) 18:44:33 INFO - PROCESS | 1948 | RSS: Main: 285188096 18:44:33 INFO - PROCESS | 1948 | 18:44:33 INFO - PROCESS | 1948 | __start_tp_report 18:44:33 INFO - PROCESS | 1948 | _x_x_mozilla_page_load 18:44:33 INFO - PROCESS | 1948 | _x_x_mozilla_page_load_details 18:44:33 INFO - PROCESS | 1948 | |i|pagename|runs| 18:44:33 INFO - PROCESS | 1948 | |0;ai-astar;114;109;116;113;115;127;113;115;117;116 18:44:33 INFO - PROCESS | 1948 | |1;audio-beat-detection;159;146;169;160;121;155;167;132;158;122 18:44:33 INFO - PROCESS | 1948 | |2;audio-dft;393;415;457;494;401;398;393;393;483;392 18:44:33 INFO - PROCESS | 1948 | |3;audio-fft;78;68;73;121;67;73;81;49;96;79 18:44:33 INFO - PROCESS | 1948 | |4;audio-oscillator;86;83;132;109;119;128;117;80;80;119 18:44:33 INFO - PROCESS | 1948 | |5;imaging-gaussian-blur;100;113;95;87;89;130;132;93;133;115 18:44:33 INFO - PROCESS | 1948 | |6;imaging-darkroom;190;255;163;161;163;159;162;160;161;161 18:44:33 INFO - PROCESS | 1948 | |7;imaging-desaturate;119;111;144;118;90;90;93;89;90;90 18:44:33 INFO - PROCESS | 1948 | |8;json-parse-financial;59;59;55;58;57;56;80;80;64;58 18:44:33 INFO - PROCESS | 1948 | |9;json-stringify-tinderbox;64;78;89;64;76;74;69;66;65;57 18:44:33 INFO - PROCESS | 1948 | |10;stanford-crypto-aes;88;84;88;87;85;85;89;85;95;90 18:44:33 INFO - PROCESS | 1948 | |11;stanford-crypto-ccm;140;112;144;135;134;131;122;132;124;125 18:44:33 INFO - PROCESS | 1948 | |12;stanford-crypto-pbkdf2;148;142;146;142;142;144;143;143;144;171 18:44:33 INFO - PROCESS | 1948 | |13;stanford-crypto-sha256-iterative;66;69;68;69;70;69;73;60;63;68 18:44:33 INFO - PROCESS | 1948 | __end_tp_report 18:44:33 INFO - PROCESS | 1948 | __start_cc_report 18:44:33 INFO - PROCESS | 1948 | _x_x_mozilla_cycle_collect,942 18:44:33 INFO - PROCESS | 1948 | __end_cc_report 18:44:33 INFO - PROCESS | 1948 | __startTimestamp1457919873350__endTimestamp 18:44:33 INFO - PROCESS | 1948 | 18:44:33 INFO - PROCESS | 1948 | ------- Summary: start ------- 18:44:33 INFO - PROCESS | 1948 | Number of tests: 14 18:44:33 INFO - PROCESS | 1948 | 18:44:33 INFO - PROCESS | 1948 | [#0] ai-astar Cycles:10 Average:115.50 Median:115.50 stddev:4.62 (4.0%) stddev-sans-first:4.87 18:44:33 INFO - PROCESS | 1948 | Values: 114.0 109.0 116.0 113.0 115.0 127.0 113.0 115.0 117.0 116.0 18:44:33 INFO - PROCESS | 1948 | 18:44:33 INFO - PROCESS | 1948 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:158.50 stddev:17.87 (11.3%) stddev-sans-first:18.57 18:44:33 INFO - PROCESS | 1948 | Values: 159.0 146.0 169.0 160.0 121.0 155.0 167.0 132.0 158.0 122.0 18:44:33 INFO - PROCESS | 1948 | 18:44:33 INFO - PROCESS | 1948 | [#2] audio-dft Cycles:10 Average:421.90 Median:408.00 stddev:40.30 (9.9%) stddev-sans-first:41.37 18:44:33 INFO - PROCESS | 1948 | Values: 393.0 415.0 457.0 494.0 401.0 398.0 393.0 393.0 483.0 392.0 18:44:33 INFO - PROCESS | 1948 | 18:44:33 INFO - PROCESS | 1948 | [#3] audio-fft Cycles:10 Average:78.50 Median:75.50 stddev:19.13 (25.3%) stddev-sans-first:20.29 18:44:33 INFO - PROCESS | 1948 | Values: 78.0 68.0 73.0 121.0 67.0 73.0 81.0 49.0 96.0 79.0 18:44:33 INFO - PROCESS | 1948 | 18:44:33 INFO - PROCESS | 1948 | [#4] audio-oscillator Cycles:10 Average:105.30 Median:106.00 stddev:20.83 (19.6%) stddev-sans-first:20.89 18:44:33 INFO - PROCESS | 1948 | Values: 86.0 83.0 132.0 109.0 119.0 128.0 117.0 80.0 80.0 119.0 18:44:33 INFO - PROCESS | 1948 | 18:44:33 INFO - PROCESS | 1948 | [#5] imaging-gaussian-blur Cycles:10 Average:108.70 Median:110.00 stddev:18.30 (16.6%) stddev-sans-first:19.14 18:44:33 INFO - PROCESS | 1948 | Values: 100.0 113.0 95.0 87.0 89.0 130.0 132.0 93.0 133.0 115.0 18:44:33 INFO - PROCESS | 1948 | 18:44:33 INFO - PROCESS | 1948 | [#6] imaging-darkroom Cycles:10 Average:173.50 Median:162.50 stddev:30.05 (18.5%) stddev-sans-first:31.28 18:44:33 INFO - PROCESS | 1948 | Values: 190.0 255.0 163.0 161.0 163.0 159.0 162.0 160.0 161.0 161.0 18:44:33 INFO - PROCESS | 1948 | 18:44:33 INFO - PROCESS | 1948 | [#7] imaging-desaturate Cycles:10 Average:103.40 Median:90.00 stddev:18.85 (20.9%) stddev-sans-first:19.12 18:44:33 INFO - PROCESS | 1948 | Values: 119.0 111.0 144.0 118.0 90.0 90.0 93.0 89.0 90.0 90.0 18:44:33 INFO - PROCESS | 1948 | 18:44:33 INFO - PROCESS | 1948 | [#8] json-parse-financial Cycles:10 Average:62.60 Median:59.00 stddev:9.48 (16.1%) stddev-sans-first:9.96 18:44:33 INFO - PROCESS | 1948 | Values: 59.0 59.0 55.0 58.0 57.0 56.0 80.0 80.0 64.0 58.0 18:44:33 INFO - PROCESS | 1948 | 18:44:33 INFO - PROCESS | 1948 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:71.50 stddev:9.19 (12.8%) stddev-sans-first:9.47 18:44:33 INFO - PROCESS | 1948 | Values: 64.0 78.0 89.0 64.0 76.0 74.0 69.0 66.0 65.0 57.0 18:44:33 INFO - PROCESS | 1948 | 18:44:33 INFO - PROCESS | 1948 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:88.00 stddev:3.27 (3.7%) stddev-sans-first:3.47 18:44:33 INFO - PROCESS | 1948 | Values: 88.0 84.0 88.0 87.0 85.0 85.0 89.0 85.0 95.0 90.0 18:44:33 INFO - PROCESS | 1948 | 18:44:33 INFO - PROCESS | 1948 | [#11] stanford-crypto-ccm Cycles:10 Average:129.90 Median:133.00 stddev:9.37 (7.0%) stddev-sans-first:9.20 18:44:33 INFO - PROCESS | 1948 | Values: 140.0 112.0 144.0 135.0 134.0 131.0 122.0 132.0 124.0 125.0 18:44:33 INFO - PROCESS | 1948 | 18:44:33 INFO - PROCESS | 1948 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.50 Median:144.00 stddev:8.82 (6.1%) stddev-sans-first:9.34 18:44:33 INFO - PROCESS | 1948 | Values: 148.0 142.0 146.0 142.0 142.0 144.0 143.0 143.0 144.0 171.0 18:44:33 INFO - PROCESS | 1948 | 18:44:33 INFO - PROCESS | 1948 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:69.00 stddev:3.69 (5.3%) stddev-sans-first:3.87 18:44:33 INFO - PROCESS | 1948 | Values: 66.0 69.0 68.0 69.0 70.0 69.0 73.0 60.0 63.0 68.0 18:44:33 INFO - PROCESS | 1948 | -------- Summary: end -------- 18:44:33 INFO - PROCESS | 1948 | 18:44:34 INFO - TEST-INFO | 1948: exit 0 18:44:34 INFO - TEST-OK | kraken | took 61718ms 18:44:34 INFO - SUITE-END | took 1173s 18:44:34 INFO - Completed test suite (00:19:33) 18:44:34 INFO - javascript benchmark 18:44:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2890.653121625405, 3468.7225021998233, 3492.284081763238, 3492.8215324055113, 3566.482859985302, 5179.456157103502, 5377.247185394043, 5783.277090363705, 5797.130430435437, 5828.708564571775, 5663.773449062043, 5750.6262092963925, 5755.971220143893, 5839.357670656224, 5915.112733090039, 5186.377634683843, 5223.529882310591, 5242.79028838846, 5294.602904782138, 5320.201969704556, 5224.92162617561, 5342.465753424646, 5426.972865135669, 5441.2654291670715, 5447.509724124828, 5057.367829021372, 5110.514501122425, 5181.093308670967, 5207.791688332462, 5324.387695415019, 5242.842714718565, 5245.082110630662, 5245.186996015624, 5264.447233040514, 5297.205419187153, 5140.7172605506685, 5209.218617207412, 5243.947560524384, 5259.631825772198, 5282.947170528284, 4846.781894814707, 5577.079781835992, 5655.434456554352, 5732.31212254528, 5732.426757324276, 5342.412334643186, 6102.511799056109, 6162.8767424651705, 6164.568480206387, 6165.7533698652, 6110.892920173586, 6139.079138129272, 6187.350328215518, 6208.068789681584, 6209.254889413254, 5897.233359663216, 5899.46904778572, 5899.882002359929, 5906.704664766745, 5950.9107363389585, 6303.149074874833, 6308.495320374359, 6311.463525600284, 6312.210973628296, 6336.968315158395, 6026.638401695912, 6113.541484388688, 6142.477889379364, 6147.985582378947, 6172.105044768484, 6143.170671959318, 6156.661383623944, 6170.629762214281, 6185.8144255672405, 6191.164192834, 6066.090086486974, 6091.934084995663, 6123.08153776937, 6171.105189747462, 6176.227971503562, 6103.004334463713, 6111.075205202202, 6138.294096178996, 6144.170536977451, 6174.0, 4956.355673762388, 4960.503949605083, 4965.677230979974, 4972.8756781080765, 4995.075910956485, 4388.561143885586, 4423.62399196072, 4427.048184640318, 4437.911241775147, 4485.461744590605, 5757.309122905278, 5900.203472531153, 5931.991561434566, 5949.0481522956115, 5980.850478738066, 6118.832384214075, 6142.600730952474, 6191.566590338633, 6215.0, 6239.688015599202, 5936.406359364029, 5966.582339236212, 5970.253718285215, 5974.970125149346, 5981.760729570856, 5288.920666189933, 5419.430959749248, 5433.157860531624, 5449.700266485302, 5451.182322651634, 6322.146510221061, 6371.267304260069, 6436.678166091677, 6461.483081353386, 6479.611223326427, 6133.785317513865, 6135.969320153549, 6177.0, 6181.258249010148, 6210.534209934363, 6255.593386429868, 6348.492120630431, 6412.775552855627, 6417.422431981144, 6452.645104519296, 6106.005662907847, 6193.876122477615, 6198.597091189058, 6204.5967012144065, 6216.937830621636, 6191.566590338633, 6194.163787888578, 6197.938020619917, 6203.906941395973, 6285.811425657238, 6011.338752737282, 6092.0252759560035, 6152.107944348134, 6154.969225153845, 6162.106494558354, 6021.7591296347655, 6117.877642447037, 6118.663473509, 6122.112293717475, 6181.598196117238, 5951.970240148945, 5959.642421454727, 5974.342822289458, 6011.308699499614, 6014.879702406015, 5997.310309314485, 6117.096718007379, 6132.8773424532155, 6134.6625935573975, 6165.876682466415, 6047.637141771508, 6051.6369017857305, 6056.454919057306, 6057.1519987200945, 6099.390060994043], "unit": "score", "name": "dojo.html", "value": 5720.227253323305}, {"lowerIsBetter": false, "replicates": [441.07154439904, 475.7621189405297, 545.1818186348528, 616.6546733829055, 651.7458191305391, 37271.62728372715, 37785.62214377856, 37923.81038094809, 37930.24139517208, 37942.24115517688, 28800.711992880064, 30463.238419039535, 35108.824455877686, 38793.61206387935, 39292.0, 9282.628694852197, 9444.102810233051, 9502.429854208769, 9550.761230969212, 9554.856677149848, 9350.812983740321, 9589.0, 9632.56653450593, 9640.80718385632, 9652.565634546427, 9408.29437792165, 9449.81100377992, 9520.8571871422, 9524.999875013127, 9537.570809313598, 9517.238620910346, 9627.47048912313, 9632.036796320383, 9643.373180743229, 9653.22774178064, 9545.856812147824, 9616.0, 9667.806643867154, 9671.371360861522, 9687.273454490942, 33174.50238246404, 38453.80773096117, 38534.42198367027, 38559.03602409934, 38602.22795544101, 3095.7059079387423, 3193.1857376368876, 3333.8833140839956, 3354.3794398036443, 3464.636213197603, 27061.188164355102, 27738.861305693343, 27798.0, 27846.3038424039, 28257.0, 2638.261286839688, 2702.2568793581922, 2721.6189733437336, 2731.0, 2813.296675831042, 434046.0, 435038.0, 438994.0, 439910.8004459989, 441359.7932010319, 44781.328280075824, 45625.54374456279, 61288.69355653193, 63076.684616576626, 63206.36793632097, 44865.0, 45241.09517809626, 45348.54651453509, 45384.0, 45597.54402456, 15162.24188790556, 15284.38862445512, 15286.770698439532, 15306.693866122616, 15318.234088295763, 11969.700757480958, 12057.698557536132, 12155.331456769785, 12182.269063856196, 12196.329201893803, 14438.855611443962, 14583.562493125222, 14777.482788102365, 14838.477458832025, 14853.2573371331, 5476.808311709071, 6270.968645156745, 6400.9039864402075, 6413.551051426355, 6424.453921416639, 810.4731924249168, 982.3369225772575, 1010.7877345757327, 1012.8328825743818, 1071.244772435431, 24938.625920611204, 25116.24651260465, 29756.40487190244, 29885.850570747443, 31580.842095789372, 979.4564016970508, 1057.9047885690325, 1072.0887245840972, 1126.4649291586431, 1132.2357408749062, 11947.207918812248, 12136.45385957634, 14112.01215914876, 14514.927425362806, 14763.557093287218, 630321.0, 633069.0, 642952.0, 644480.0, 646291.0, 49437.25844112341, 58185.709071454374, 58279.834403311695, 58744.41255587475, 58893.411065889646, 1378.4486205517674, 1405.8242719660043, 1410.4851729119002, 1428.0860249440366, 1434.5767998440485, 28067.438651226454, 28075.73659185301, 28079.97064569566, 28527.572086419135, 28632.284192895346, 48557.514424856716, 48564.0, 48586.0, 49053.50946490489, 49081.50918490912, 406343.0, 407510.0, 408693.95653021545, 409381.0, 410536.0, 30064.84967575148, 31717.524237136924, 32703.672963270063, 33236.335273294884, 33546.66453335436, 35377.11557210988, 43074.78462607667, 43533.34699979566, 43801.78099109484, 44414.0, 35777.82111089428, 36061.63938360583, 36247.0, 36901.26197476089, 37144.0, 30067.248318792204, 35119.29761404809, 35892.49041877574, 36071.639283606826, 36976.81511592425, 30668.539971900886, 35049.59801607907, 35138.29723405569, 36196.81901590475, 36494.63505364912, 29820.85089574538, 30110.838361971677, 30125.397492050473, 30171.849140754155, 30350.696493034786, 20783.896080519502, 23576.410589735395, 24015.159469419184, 24166.637500437155, 24467.021319147036], "unit": "score", "name": "ext.html", "value": 18572.261175235617}, {"lowerIsBetter": false, "replicates": [317.38585836406554, 348.6182630020128, 349.98504337421474, 351.8012323037482, 365.12552436913575, 17494.21276042578, 19637.607247855034, 20773.27293544726, 20980.580388392224, 21005.579888402222, 20317.88251646159, 20968.475788105305, 21212.363629091153, 21215.257465988692, 21236.8938155309, 5494.780208791643, 5751.0, 5798.768049278024, 5817.534597232211, 5841.853953651172, 4121.711480196387, 6062.848428789272, 6480.675966201695, 6496.123023391852, 6508.837279068038, 6414.134091897581, 6420.839479013039, 6432.292447830735, 6454.0, 6904.9654751726175, 6340.968295158495, 7062.470314726416, 7122.824733918897, 7123.145222573273, 7170.354668079872, 6654.767083152066, 7074.186468556079, 7102.183248926388, 7114.57312561248, 7124.928750712478, 25775.613365799527, 26549.601755973676, 26913.0, 26931.32671683204, 27411.451770964668, 2187.7484089329773, 2266.0, 2339.675547755533, 2595.8961641534315, 3034.0, 12903.483860645563, 15300.186258794887, 15358.0, 15640.139792311418, 16006.519804405887, 1670.991645041779, 1860.5348662834292, 1871.56018335691, 1950.1126987220923, 1956.383739122172, 106653.46673266661, 115065.0, 115721.84278157195, 116148.41925790401, 116589.41705291504, 15606.843931560767, 19324.420267392, 19562.60874782525, 19775.703364449546, 19855.205791768458, 28695.42609147847, 29143.271418214714, 29198.416031679673, 29228.0, 29299.85350073236, 10502.632407865687, 10671.466426678635, 10808.97314755097, 10843.83734243987, 10982.615608453665, 7481.027466429438, 9055.81888362229, 9112.544372781467, 9135.634574617074, 9225.354225204306, 8046.1551537088935, 8946.0, 8989.146031127033, 8999.460032398078, 9015.27877769777, 1664.0265444714735, 1874.8406385457115, 1954.7263383126374, 1972.053414361086, 1977.0905383523452, 881.5460038080394, 931.1759093202429, 993.1855878179967, 1025.5590096258532, 1047.9056884880397, 19429.611407771765, 19683.901580492293, 20230.494237644176, 20307.081231318905, 20868.79131208699, 929.8419268724333, 939.4316438554713, 957.3868032365486, 961.5144352102284, 965.3242730088825, 10919.071878890225, 11050.950159734812, 11124.55501779936, 11275.548978040786, 11305.943470282597, 614519.0, 647981.0, 649895.0, 655206.0, 661950.0, 118896.0, 120589.0, 123198.38400807939, 125260.0, 132101.0, 994.3089552760906, 1054.4464156317995, 1058.3544038136731, 1058.6453538064682, 1065.0308219520355, 13504.662383440493, 18398.08009599488, 18786.060696964825, 18866.71699924475, 18935.526611834262, 37135.81432092822, 49430.0, 49860.501394985586, 51003.489965101355, 51060.0, 70204.13877236801, 70315.64842175962, 74520.0, 75746.62126689331, 76648.61675691586, 7447.255274472726, 7599.696012159452, 7647.847043059219, 7701.768946931601, 7964.2433968772875, 7964.960175199087, 12060.396980150781, 12122.515099395925, 12251.0, 12281.631551053482, 8449.66201351939, 9468.905310946802, 10159.695209143738, 10509.31689440184, 10622.681319560426, 8367.330613551023, 10366.844497332395, 10444.791104178026, 10606.681799546026, 10635.415052172204, 5614.326280846324, 8249.958750206211, 8640.703894415888, 9131.0, 10757.838632420677, 7562.584057876869, 7651.4261430391825, 7704.0, 7723.227677232457, 7817.882731759142, 9155.587998540215, 9328.207102396373, 10324.845127322946, 10466.0, 10857.945710271399], "unit": "score", "name": "jquery.html", "value": 10159.853247741288}, {"lowerIsBetter": false, "replicates": [1465.4358072142225, 1598.7761713360132, 1819.5451137215696, 1961.2743284984558, 1982.6728589782686, 7910.208979102087, 8741.344399170055, 8835.072317406677, 9015.549222538872, 9038.457692538452, 8779.165979231979, 8806.0, 8878.689245876396, 8878.689245876396, 8886.333524985619, 2123.681447782837, 2494.526040052389, 2507.6238564215423, 2511.3972646564785, 2512.472380800034, 2104.4738815296178, 2474.6288056791445, 2511.9120830770835, 2518.798496120315, 2525.368657835541, 2493.1523282084086, 2505.7243703192635, 2525.2424272718204, 2540.0728734012046, 2542.1102614085107, 2497.400623850281, 2516.509280690266, 2522.1928982725444, 2531.2785856031037, 2540.593505039185, 2499.150288901764, 2524.5960646296503, 2525.1414519063424, 2528.1783420388265, 2538.3019669590826, 8976.910230897673, 9002.86495702565, 9020.8646870297, 9022.052684468168, 9023.278137748965, 5465.234867118606, 5559.0, 5569.777208911639, 5616.943830561683, 5627.0, 3573.427691815593, 3675.5956844747056, 3695.7043436525014, 3722.664960153572, 3752.3245815753153, 1039.7816458543714, 1048.9370637761758, 1063.059192614534, 1066.0352381095045, 1080.0441609175857, 11911.940440297829, 12006.459709313101, 12145.878541214563, 12174.878251217464, 12175.817362739566, 4917.877053073702, 4950.554450099508, 5022.472640372781, 5027.044861476308, 5028.396592408934, 8315.459495132796, 10281.485925703684, 10309.48452577383, 10323.432211228455, 10328.845067323997, 5444.237806707064, 5501.339839219239, 5509.669419834742, 5516.117421212587, 5527.0, 4538.273876179861, 4921.655484116149, 4922.0, 4930.457649658535, 5051.823186188466, 3940.0937784309767, 4008.5590585035625, 4014.297497937849, 4071.0840060986043, 4108.609682080198, 1324.7549203397402, 1348.1169833758904, 1349.8312710911136, 1355.0650051464459, 1361.720847226336, 1305.902057345684, 1342.047146525958, 1342.4495956657724, 1345.9259740714356, 1405.0305289350315, 8058.919410805935, 8271.834563308821, 8277.54473503963, 8323.916760832315, 8364.414490985695, 446.187937952929, 508.97964081437067, 520.828126718182, 523.0558841291505, 524.9081410753103, 6193.6903154842075, 6247.031710084944, 6269.498440124779, 6285.120083188357, 6296.716647750771, 10372.636957706443, 10465.895341046644, 10513.158947284199, 10583.206259530565, 10636.989485998818, 10226.795464090825, 10426.374417534973, 10487.475626218658, 10507.474626268657, 10549.789004219872, 8235.95882020586, 8289.751307460785, 8362.58187090643, 8368.20502052304, 8370.581470926429, 8058.959705201437, 8118.715844945635, 8126.715564955198, 8180.8363832721825, 8386.161383861565, 9604.327697061139, 9771.706848794547, 9813.950930245303, 9833.0, 9836.60653573849, 9785.951070244888, 10103.24225683062, 10179.592816287563, 10241.487925603838, 10355.01627345401, 6747.730090796314, 7526.887096693664, 7594.392448604209, 7638.388928885787, 7755.379569634303, 8315.750527484186, 8348.624311905858, 8368.790780230544, 8371.16288371158, 8387.412881098264, 6533.607983521004, 7354.852902941804, 7449.888251676338, 7489.925100748923, 7628.656710448154, 6224.0, 6356.650384228912, 7319.560826350436, 7337.046183996046, 7521.849563008818, 7526.5107767994905, 7694.576798275924, 7728.806779830325, 7734.381249499914, 7764.961175194314, 7012.754553590804, 7052.153741550842, 7069.257727938492, 7112.928870711434, 7162.964185179041, 7099.148102227766, 7237.674304656409, 7247.91281307808, 7274.672639731119, 7295.7081716732855], "unit": "score", "name": "mootools.html", "value": 4901.517533735807}, {"lowerIsBetter": false, "replicates": [314.7969559634036, 324.7045188878121, 328.64013904774265, 332.1530098249463, 332.5012481278083, 5458.0, 6843.452523798097, 6884.5525040872435, 6885.0, 6920.996455513948, 5375.650582712131, 6688.498362622799, 6739.0902228199175, 6756.527043106985, 6790.660466976644, 4870.220764677652, 4960.479149689285, 5063.240513922904, 5091.312672789181, 5130.743462826853, 5050.898982020358, 5065.468125846788, 5069.315642388286, 5075.137226671474, 5099.898002039957, 5001.199808030716, 5011.67424117433, 5034.42104158021, 5037.0, 5050.747462626872, 5001.524855138756, 5018.673786203922, 5035.697858128506, 5036.4208116066575, 5037.909267653919, 3592.892213233607, 3821.3694740367805, 4101.666958238585, 4336.934945975813, 4350.2387082260475, 5328.5470734987575, 5519.074890308143, 6313.400226978476, 6627.867442651168, 6642.036904648847, 5738.0, 5839.270091238595, 5858.297004359504, 5858.794942177004, 5859.355470898197, 7319.926800731978, 7320.304571065741, 7334.083239595051, 7341.1557670868, 7354.889676654854, 4653.837115700934, 4656.953430465685, 4657.022025374676, 4658.440987081538, 4659.5573420525, 7338.412926965883, 7668.309852113337, 7748.024253815297, 7760.883586746203, 7775.727849525239, 4596.2416201326405, 4609.469910960215, 4700.741459219707, 4712.693674911188, 4730.101280756645, 4786.856394308176, 4792.640551958617, 4795.400574928134, 4797.544233297831, 4812.181929072066, 4998.750062496933, 5509.834704958857, 5690.5163061140265, 5752.28096487939, 5780.450857168562, 7321.450891183183, 7328.083989501312, 7328.67020984057, 7345.963270183614, 7355.0, 1564.0615630621537, 1610.8147563030168, 1618.757186422046, 1647.7116504611645, 1650.6533627938268, 1044.3629386074488, 1053.847192157133, 1062.2404980438869, 1067.813132701774, 1068.7648717282186, 6255.499560035186, 6822.0, 6835.282295358916, 6844.965775171092, 6901.240863505011, 6134.877302454015, 6540.4767618590395, 7569.735059273009, 7582.54504729707, 7613.695452181962, 6853.246142924274, 6857.759978400732, 6859.3140685932, 6866.313368663094, 6988.755393561201, 3370.0563842124243, 3586.30067136911, 3997.8400863965117, 4023.275810354106, 4045.939310910339, 6595.934040659628, 6754.763583274562, 7863.0, 8049.074356448966, 8062.234087761653, 7845.843083138419, 7910.16943220965, 7911.378167475654, 7915.327197188189, 7917.960410198028, 7997.5601341925585, 8016.55908925003, 8021.197880211932, 8033.277005069572, 8050.718224862102, 7301.452391070585, 7635.0, 7643.808904777425, 7659.770206893802, 7667.693292268247, 7456.105267367951, 7461.365783908429, 7465.4027677786735, 7466.0, 7487.5507469552, 6477.902831457438, 7953.204679532, 7959.9602001989615, 7979.202079791974, 7990.121086680577, 4696.38946936896, 4755.952440475689, 4763.166445872028, 4767.165745994506, 4772.952270477251, 7353.227911069261, 7606.581638009962, 7654.081510218809, 7654.502457340255, 7675.5010924289745, 6679.532432729662, 6757.797266082025, 7340.596267205141, 7361.742339018108, 7369.889451658122, 7345.77962661121, 7393.519421237603, 7406.925930740624, 7424.96287518559, 7439.739609113655, 7157.57054576727, 7173.820654483471, 7215.783526494003, 7218.133823941161, 7222.313880181375, 6637.269900311058, 6810.727570897108, 7352.852942941218, 7388.778336649909, 7406.5926374047785, 7183.928160718535, 7220.89168662481, 7231.963840180765, 7233.3851622612665, 7242.746503872339], "unit": "score", "name": "prototype.html", "value": 5267.643458279054}, {"lowerIsBetter": false, "replicates": [692.2834865913778, 718.3104219948849, 743.215907217885, 775.1589525364978, 776.1113525013859, 14968.32642531086, 15187.772183417257, 15225.390984360612, 15244.61888452788, 15257.847421525781, 13878.0, 14075.648108797259, 14141.080829746059, 14149.434022639109, 14195.148291102541, 711.3562226185311, 918.9448633082003, 920.9907900921005, 931.1340453378356, 931.7996630724393, 912.4707669551644, 922.598669578732, 923.1829830599934, 924.7872989212485, 926.819270242303, 972.2853702528636, 975.0834215837091, 975.7755716185281, 976.4727047394399, 976.716752141878, 963.4460185393357, 967.4630580028081, 970.8301047316692, 975.2880397309968, 975.5463709375103, 705.8447141628833, 721.90976127984, 726.8255618651539, 730.1420830524113, 732.42870560962, 13250.271235082068, 13282.203067815866, 13284.202947823162, 13317.800232996513, 13396.196228226338, 11143.665690029313, 11257.268277562014, 11695.649130526097, 12273.263604183778, 12586.559470418491, 9799.461029643368, 9854.556544955494, 9902.0, 9937.155341795957, 10007.099361057468, 3513.543239378864, 3525.594556625995, 3554.36021516127, 3571.5178450909057, 3592.281543691246, 70624.0, 80512.79230811483, 81566.0, 81572.59213703894, 86127.0, 9725.56234969428, 9797.951010244904, 9833.4099954003, 9880.40717556949, 9965.900340996643, 21606.996853398206, 22304.665430018238, 22386.888065559568, 22447.55104897893, 22469.775302247097, 7641.923580764233, 7793.376529877596, 7833.92166078332, 7910.920890791133, 7992.200779921961, 4073.551909289976, 4148.668106551529, 4173.9582604174175, 4174.979125104355, 4192.832286708558, 3635.6727894489622, 3668.486411902336, 3669.522962014921, 3675.0, 3685.8341374638208, 578.4475825586638, 653.1313353240179, 695.3220609905302, 698.8252936765808, 699.2727563334178, 499.93500844889934, 518.0623072239184, 545.4000599340773, 582.8309790160806, 594.3933182674541, 8042.831647828743, 8283.50298982063, 8333.499990000499, 8359.916400835913, 8417.158284171657, 487.4930072724398, 549.5301517202814, 551.1752269618206, 559.5383808358121, 590.008591875951, 3567.6253993330847, 3766.0, 4161.56303588125, 4233.322668373045, 4339.327404252346, 94564.52717736505, 97349.0, 97546.0, 97708.51145744367, 99135.0, 59049.0, 81988.18011819806, 82111.5894420536, 82169.17830821616, 82463.0, 66694.0, 67143.32856671468, 67667.32332676709, 68288.65855670789, 68632.6568367155, 7558.2441755823975, 7664.923350766421, 8526.659433966997, 8545.786355341166, 8548.829023419621, 40683.0, 48507.757461212466, 50261.0, 50389.0, 50857.491425085274, 55777.44222557722, 66563.0, 68439.31560684329, 70750.64624676843, 71316.28683713096, 11011.61459348919, 11185.440727963733, 11278.266912650652, 11281.379524126252, 11475.713107172387, 11878.643640690792, 12186.6953326164, 12411.255324680547, 12422.0, 12706.047046471736, 11541.653750387502, 11556.59551915679, 11953.103517236415, 12007.939960300142, 12142.028637709138, 10832.566697332019, 11693.941530292293, 11835.70410739704, 11962.58130965412, 11997.76004479923, 9941.403515789076, 11419.657410277705, 11602.825957610812, 11814.0, 12395.75208495843, 9642.951785241028, 9831.606735730491, 9870.703878883645, 9927.503624818586, 10127.7468063299, 9046.90953090487, 9077.863832042392, 9301.162895339452, 9679.274054445805, 9742.853857192289], "unit": "score", "name": "yui.html", "value": 6930.2110480945885}], "name": "dromaeo_css", "value": 7602.947422752893}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 109.0, 116.0, 113.0, 115.0, 127.0, 113.0, 115.0, 117.0, 116.0], "unit": "score", "name": "ai-astar", "value": 115.5}, {"lowerIsBetter": true, "replicates": [159.0, 146.0, 169.0, 160.0, 121.0, 155.0, 167.0, 132.0, 158.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 148.9}, {"lowerIsBetter": true, "replicates": [393.0, 415.0, 457.0, 494.0, 401.0, 398.0, 393.0, 393.0, 483.0, 392.0], "unit": "score", "name": "audio-dft", "value": 421.9}, {"lowerIsBetter": true, "replicates": [78.0, 68.0, 73.0, 121.0, 67.0, 73.0, 81.0, 49.0, 96.0, 79.0], "unit": "score", "name": "audio-fft", "value": 78.5}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 132.0, 109.0, 119.0, 128.0, 117.0, 80.0, 80.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 105.3}, {"lowerIsBetter": true, "replicates": [100.0, 113.0, 95.0, 87.0, 89.0, 130.0, 132.0, 93.0, 133.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.7}, {"lowerIsBetter": true, "replicates": [190.0, 255.0, 163.0, 161.0, 163.0, 159.0, 162.0, 160.0, 161.0, 161.0], "unit": "score", "name": "imaging-darkroom", "value": 173.5}, {"lowerIsBetter": true, "replicates": [119.0, 111.0, 144.0, 118.0, 90.0, 90.0, 93.0, 89.0, 90.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 103.4}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 55.0, 58.0, 57.0, 56.0, 80.0, 80.0, 64.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 62.6}, {"lowerIsBetter": true, "replicates": [64.0, 78.0, 89.0, 64.0, 76.0, 74.0, 69.0, 66.0, 65.0, 57.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.2}, {"lowerIsBetter": true, "replicates": [88.0, 84.0, 88.0, 87.0, 85.0, 85.0, 89.0, 85.0, 95.0, 90.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.6}, {"lowerIsBetter": true, "replicates": [140.0, 112.0, 144.0, 135.0, 134.0, 131.0, 122.0, 132.0, 124.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.9}, {"lowerIsBetter": true, "replicates": [148.0, 142.0, 146.0, 142.0, 142.0, 144.0, 143.0, 143.0, 144.0, 171.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.5}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 68.0, 69.0, 70.0, 69.0, 73.0, 60.0, 63.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1820.0}]} 18:44:34 INFO - Return code: 0 18:44:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:44:34 ERROR - # TBPL SUCCESS # 18:44:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:44:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:44:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:44:34 INFO - 2016-03-13 18:44:34.656 screenresolution[1953:18320] starting screenresolution argv=screenresolution get 18:44:34 INFO - 2016-03-13 18:44:34.658 screenresolution[1953:18320] Display 0: 1600x1200x32@60 18:44:34 INFO - 2016-03-13 18:44:34.664 screenresolution[1954:18323] starting screenresolution argv=screenresolution list 18:44:34 INFO - Available Modes on Display 0 18:44:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:44:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:44:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:44:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:44:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:44:34 INFO - Intel Iris: 18:44:34 INFO - Chipset Model: Intel Iris 18:44:34 INFO - Type: GPU 18:44:34 INFO - Bus: Built-In 18:44:34 INFO - VRAM (Dynamic, Max): 1536 MB 18:44:34 INFO - Vendor: Intel (0x8086) 18:44:34 INFO - Device ID: 0x0a2e 18:44:34 INFO - Revision ID: 0x0009 18:44:34 INFO - Displays: 18:44:34 INFO - Display: 18:44:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:44:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:44:34 INFO - Display Serial Number: 1600x1200 60 18:44:34 INFO - Main Display: Yes 18:44:34 INFO - Mirror: Off 18:44:34 INFO - Online: Yes 18:44:34 INFO - Rotation: Supported 18:44:34 INFO - Return code: 0 18:44:34 INFO - Running post-action listener: _resource_record_post_action 18:44:34 INFO - Running post-run listener: _resource_record_post_run 18:44:35 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 2928640; Write bytes: 707361792; Read time: 51; Write time: 2097 18:44:35 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 402522624; Write bytes: 403728384; Read time: 30095; Write time: 745 18:44:35 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 2928640; Write bytes: 302785536; Read time: 51; Write time: 1349 18:44:35 INFO - Running post-run listener: _upload_blobber_files 18:44:35 INFO - Blob upload gear active. 18:44:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:44:35 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 18:44:35 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'] 18:44:35 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 18:44:36 INFO - (blobuploader) - INFO - Open directory for files ... 18:44:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:44:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:44:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:44:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:44:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:44:37 INFO - (blobuploader) - INFO - Done attempting. 18:44:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:44:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:44:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:44:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:44:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:44:38 INFO - (blobuploader) - INFO - Done attempting. 18:44:38 INFO - (blobuploader) - INFO - Iteration through files over. 18:44:38 INFO - Return code: 0 18:44:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:44:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:44:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f74a2292fe13b12647d66d903ac4172ae61e18828e7bc53c63549b6c3912107c76d1eabb728e44eb0c25bbaa1a6f07a802f5baa53db37a409a8e13867b39eb2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3d61cd6d191447e4ab99c66896cfdf9566c520ee83d0f373f7281a45eae162cfe2aee49a2cb628e0183a35c8fc86eafb094450ee272111c1cce97643396f073"} 18:44:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:44:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:44:38 INFO - Contents: 18:44:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f74a2292fe13b12647d66d903ac4172ae61e18828e7bc53c63549b6c3912107c76d1eabb728e44eb0c25bbaa1a6f07a802f5baa53db37a409a8e13867b39eb2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3d61cd6d191447e4ab99c66896cfdf9566c520ee83d0f373f7281a45eae162cfe2aee49a2cb628e0183a35c8fc86eafb094450ee272111c1cce97643396f073"} 18:44:38 INFO - Running post-run listener: copy_logs_to_upload_dir 18:44:38 INFO - Copying logs to upload dir... 18:44:38 INFO - mkdir: /builds/slave/test/build/upload/logs 18:44:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.437484 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-03-13 18:44:38.666060) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-13 18:44:38.669472) ========= 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.y1MUSjYWWI/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.8t8q8pVwII/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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/9f74a2292fe13b12647d66d903ac4172ae61e18828e7bc53c63549b6c3912107c76d1eabb728e44eb0c25bbaa1a6f07a802f5baa53db37a409a8e13867b39eb2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3d61cd6d191447e4ab99c66896cfdf9566c520ee83d0f373f7281a45eae162cfe2aee49a2cb628e0183a35c8fc86eafb094450ee272111c1cce97643396f073"} build_url:https://queue.taskcluster.net/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011241 build_url: 'https://queue.taskcluster.net/v1/task/XukmvJOBTAi0Smka7DGMxA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f74a2292fe13b12647d66d903ac4172ae61e18828e7bc53c63549b6c3912107c76d1eabb728e44eb0c25bbaa1a6f07a802f5baa53db37a409a8e13867b39eb2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3d61cd6d191447e4ab99c66896cfdf9566c520ee83d0f373f7281a45eae162cfe2aee49a2cb628e0183a35c8fc86eafb094450ee272111c1cce97643396f073"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-13 18:44:38.697127) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 18:44:38.697466) ========= 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.y1MUSjYWWI/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.8t8q8pVwII/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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.005288 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 18:44:38.745927) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-13 18:44:38.746293) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-13 18:44:38.746661) ========= ========= Total master_lag: 0.26 =========